builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1476980154.09 results: success (0) buildid: 20161020074550 builduid: 6b1f0f2726af4cbd8b2403ba5ceade1d revision: c2753c9ba68ebd62aa8c086e7f36835ebd064044 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.094329) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.095040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.095569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.108948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.109238) ========= 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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 09:15:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2016-10-20 09:15:54 (37.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.218176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.218961) ========= 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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018024 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:54.273232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 09:15:54.273969) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2753c9ba68ebd62aa8c086e7f36835ebd064044 --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 c2753c9ba68ebd62aa8c086e7f36835ebd064044 --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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 09:15:54,663 truncating revision to first 12 chars 2016-10-20 09:15:54,663 Setting DEBUG logging. 2016-10-20 09:15:54,663 attempt 1/10 2016-10-20 09:15:54,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2753c9ba68e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 09:15:55,979 unpacking tar archive at: mozilla-central-c2753c9ba68e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 09:15:55.939881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:55.940620) ========= script_repo_revision: c2753c9ba68ebd62aa8c086e7f36835ebd064044 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:55.941593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:55.942073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:15:55.953757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-20 09:15:55.954357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:56 INFO - MultiFileLogger online at 20161020 09:15:56 in /builds/slave/test 09:15:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:15:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:56 INFO - {'append_to_log': False, 09:15:56 INFO - 'base_work_dir': '/builds/slave/test', 09:15:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:15:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:56 INFO - 'branch': 'Firefox-Non-PGO', 09:15:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:56 INFO - 'config_files': ('talos/linux_config.py',), 09:15:56 INFO - 'default_actions': ('clobber', 09:15:56 INFO - 'read-buildbot-config', 09:15:56 INFO - 'download-and-extract', 09:15:56 INFO - 'populate-webroot', 09:15:56 INFO - 'create-virtualenv', 09:15:56 INFO - 'install', 09:15:56 INFO - 'run-tests'), 09:15:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:56 INFO - 'download_minidump_stackwalk': True, 09:15:56 INFO - 'download_symbols': 'ondemand', 09:15:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:56 INFO - 'installer_path': 'installer.exe', 09:15:56 INFO - 'log_level': 'info', 09:15:56 INFO - 'log_name': 'talos', 09:15:56 INFO - 'log_to_console': True, 09:15:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:56 INFO - 'opt_config_files': (), 09:15:56 INFO - 'pip_index': False, 09:15:56 INFO - 'sps_profile': False, 09:15:56 INFO - 'sps_profile_interval': 0, 09:15:56 INFO - 'suite': 'dromaeojs-e10s', 09:15:56 INFO - 'system_bits': '32', 09:15:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:56 INFO - 'title': 'talos-linux64-ix-031', 09:15:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:56 INFO - 'use_talos_json': True, 09:15:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:56 INFO - 'work_dir': 'build'} 09:15:56 INFO - [mozharness: 2016-10-20 16:15:56.446184Z] Running clobber step. 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: clobber 09:15:56 INFO - rmtree: /builds/slave/test/build 09:15:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:56 INFO - Running post-action listener: _resource_record_post_action 09:15:56 INFO - [mozharness: 2016-10-20 16:15:56.896433Z] Finished clobber step (success) 09:15:56 INFO - [mozharness: 2016-10-20 16:15:56.896532Z] Running read-buildbot-config step. 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: read_buildbot_config 09:15:56 INFO - Using buildbot properties: 09:15:56 INFO - { 09:15:56 INFO - "project": "", 09:15:56 INFO - "product": "firefox", 09:15:56 INFO - "script_repo_revision": "production", 09:15:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:15:56 INFO - "repository": "", 09:15:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:15:56 INFO - "buildid": "20161020074550", 09:15:56 INFO - "pgo_build": "False", 09:15:56 INFO - "basedir": "/builds/slave/test", 09:15:56 INFO - "buildnumber": 245, 09:15:56 INFO - "slavename": "talos-linux64-ix-031", 09:15:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:15:56 INFO - "platform": "ubuntu64_hw", 09:15:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:15:56 INFO - "branch": "mozilla-central", 09:15:56 INFO - "repo_path": "mozilla-central", 09:15:56 INFO - "revision": "c2753c9ba68ebd62aa8c086e7f36835ebd064044", 09:15:56 INFO - "stage_platform": "linux64", 09:15:56 INFO - "builduid": "6b1f0f2726af4cbd8b2403ba5ceade1d", 09:15:56 INFO - "slavebuilddir": "test" 09:15:56 INFO - } 09:15:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:15:56 INFO - Running post-action listener: _resource_record_post_action 09:15:56 INFO - [mozharness: 2016-10-20 16:15:56.898950Z] Finished read-buildbot-config step (success) 09:15:56 INFO - [mozharness: 2016-10-20 16:15:56.899037Z] Running download-and-extract step. 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: download_and_extract 09:15:56 INFO - mkdir: /builds/slave/test/build/tests 09:15:56 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')]} 09:15:56 INFO - trying https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:15:56 INFO - Downloading https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:15:57 INFO - Downloaded 1361 bytes. 09:15:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:15:57 INFO - Using the following test package requirements: 09:15:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:15:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'jsshell-linux-x86_64.zip'], 09:15:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:15:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:15:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:15:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:57 INFO - Fetch https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:15:58 INFO - Http code: 200 09:15:58 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:15:58 INFO - x-amz-cf-id: Jo7QCTT-Jt_vBrl33ykV1Ch5at8NLpliPNenlaTt0FfuXJ4xgw4nSA== 09:15:58 INFO - x-amz-version-id: Maj0ru5CZSi5Dlbg09DmoJbDeL315q3F 09:15:58 INFO - Expected file size: 20547606 09:15:58 INFO - Obtained file size: 20547606 09:16:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:16:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:16:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:16:03 INFO - Http code: 200 09:16:03 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 09:16:03 INFO - x-amz-cf-id: Pqyz-Yv0uTUQHCEnP5PGDhWev83m8cPiSFTKfBOfdIHZWdhCqOJNug== 09:16:03 INFO - x-amz-version-id: Maj0ru5CZSi5Dlbg09DmoJbDeL315q3F 09:16:03 INFO - Expected file size: 20547606 09:16:03 INFO - Obtained file size: 20547606 09:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:16:08 INFO - Http code: 200 09:16:08 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:16:08 INFO - x-amz-cf-id: o8a8hB9OZueXxsGl5ldkSDv9_7CaMmFb5Y-dFzoz3LGLcJOJP7gArg== 09:16:08 INFO - x-amz-version-id: D.yxwyae3E_j2.o9z2mnf7BE3qQ_ricH 09:16:09 INFO - Expected file size: 14409028 09:16:09 INFO - Obtained file size: 14409028 09:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:09 INFO - trying https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:16:09 INFO - Downloading https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:16:11 INFO - Downloaded 55543728 bytes. 09:16:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:16:11 INFO - mkdir: /builds/slave/test/properties 09:16:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:11 INFO - Contents: 09:16:11 INFO - build_url:https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:16:12 INFO - Running post-action listener: _resource_record_post_action 09:16:12 INFO - Running post-action listener: set_extra_try_arguments 09:16:12 INFO - [mozharness: 2016-10-20 16:16:12.499665Z] Finished download-and-extract step (success) 09:16:12 INFO - [mozharness: 2016-10-20 16:16:12.499889Z] Running populate-webroot step. 09:16:12 INFO - Running pre-action listener: _resource_record_pre_action 09:16:12 INFO - Running main action method: populate_webroot 09:16:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:12 INFO - '--tppagecycles', 09:16:12 INFO - '7'], 09:16:12 INFO - 'tests': ['tsvgm']}}, 09:16:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['damp', 'tps']}, 09:16:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['damp', 'tps']}, 09:16:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['dromaeo_dom']}, 09:16:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['basic_compositor_video']}, 09:16:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tsvgx', 09:16:12 INFO - 'tsvgr_opacity', 09:16:12 INFO - 'tart', 09:16:12 INFO - 'tscrollx', 09:16:12 INFO - 'cart']}, 09:16:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:12 INFO - 'tsvgr_opacity', 09:16:12 INFO - 'tart', 09:16:12 INFO - 'tscrollx', 09:16:12 INFO - 'cart']}, 09:16:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tp5o']}, 09:16:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['tp5o']}, 09:16:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s', 09:16:12 INFO - '--xperf_path', 09:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:12 INFO - 'tests': ['tp5n']}, 09:16:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--xperf_path', 09:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:12 INFO - 'tests': ['tp5n']}}, 09:16:12 INFO - 'talos.zip': {'path': '', 09:16:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:12 INFO - Running post-action listener: _resource_record_post_action 09:16:12 INFO - [mozharness: 2016-10-20 16:16:12.518934Z] Finished populate-webroot step (success) 09:16:12 INFO - [mozharness: 2016-10-20 16:16:12.519021Z] Running create-virtualenv step. 09:16:12 INFO - Running pre-action listener: _resource_record_pre_action 09:16:12 INFO - Running main action method: create_virtualenv 09:16:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:12 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 09:16:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:12 INFO - Using real prefix '/usr' 09:16:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:15 INFO - Installing pip.................done. 09:16:15 INFO - Return code: 0 09:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:15 INFO - Reading from file tmpfile_stdout 09:16:15 INFO - Output received: 09:16:15 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) 09:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:15 INFO - Using env: {'DISPLAY': ':0', 09:16:15 INFO - 'HOME': '/home/cltbld', 09:16:15 INFO - 'LANG': 'en_US.UTF-8', 09:16:15 INFO - 'LANGUAGE': 'en_US:en', 09:16:15 INFO - 'LOGNAME': 'cltbld', 09:16:15 INFO - 'MAIL': '/var/mail/cltbld', 09:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:15 INFO - 'MOZ_NO_REMOTE': '1', 09:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:15 INFO - 'NO_EM_RESTART': '1', 09:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:15 INFO - 'PWD': '/builds/slave/test', 09:16:15 INFO - 'SHELL': '/bin/bash', 09:16:15 INFO - 'SHLVL': '1', 09:16:15 INFO - 'TERM': 'linux', 09:16:15 INFO - 'TMOUT': '86400', 09:16:15 INFO - 'USER': 'cltbld', 09:16:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:15 INFO - '_': '/tools/buildbot/bin/python'} 09:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:15 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 09:16:15 INFO - Cleaning up... 09:16:15 INFO - Return code: 0 09:16:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:15 INFO - Using env: {'DISPLAY': ':0', 09:16:15 INFO - 'HOME': '/home/cltbld', 09:16:15 INFO - 'LANG': 'en_US.UTF-8', 09:16:15 INFO - 'LANGUAGE': 'en_US:en', 09:16:15 INFO - 'LOGNAME': 'cltbld', 09:16:15 INFO - 'MAIL': '/var/mail/cltbld', 09:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:15 INFO - 'MOZ_NO_REMOTE': '1', 09:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:15 INFO - 'NO_EM_RESTART': '1', 09:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:15 INFO - 'PWD': '/builds/slave/test', 09:16:15 INFO - 'SHELL': '/bin/bash', 09:16:15 INFO - 'SHLVL': '1', 09:16:15 INFO - 'TERM': 'linux', 09:16:15 INFO - 'TMOUT': '86400', 09:16:15 INFO - 'USER': 'cltbld', 09:16:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:15 INFO - '_': '/tools/buildbot/bin/python'} 09:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:15 INFO - Downloading/unpacking psutil>=3.1.1 09:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:17 INFO - Installing collected packages: psutil 09:16:17 INFO - Running setup.py install for psutil 09:16:17 INFO - building 'psutil._psutil_linux' extension 09:16:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:16:18 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 09:16:18 INFO - building 'psutil._psutil_posix' extension 09:16:18 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 09:16:18 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 09:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:18 INFO - Successfully installed psutil 09:16:18 INFO - Cleaning up... 09:16:18 INFO - Return code: 0 09:16:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:16:18 INFO - Using env: {'DISPLAY': ':0', 09:16:18 INFO - 'HOME': '/home/cltbld', 09:16:18 INFO - 'LANG': 'en_US.UTF-8', 09:16:18 INFO - 'LANGUAGE': 'en_US:en', 09:16:18 INFO - 'LOGNAME': 'cltbld', 09:16:18 INFO - 'MAIL': '/var/mail/cltbld', 09:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:18 INFO - 'MOZ_NO_REMOTE': '1', 09:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:18 INFO - 'NO_EM_RESTART': '1', 09:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:18 INFO - 'PWD': '/builds/slave/test', 09:16:18 INFO - 'SHELL': '/bin/bash', 09:16:18 INFO - 'SHLVL': '1', 09:16:18 INFO - 'TERM': 'linux', 09:16:18 INFO - 'TMOUT': '86400', 09:16:18 INFO - 'USER': 'cltbld', 09:16:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:18 INFO - '_': '/tools/buildbot/bin/python'} 09:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:20 INFO - Installing collected packages: mozsystemmonitor 09:16:20 INFO - Running setup.py install for mozsystemmonitor 09:16:20 INFO - Successfully installed mozsystemmonitor 09:16:20 INFO - Cleaning up... 09:16:20 INFO - Return code: 0 09:16:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:20 INFO - Using env: {'DISPLAY': ':0', 09:16:20 INFO - 'HOME': '/home/cltbld', 09:16:20 INFO - 'LANG': 'en_US.UTF-8', 09:16:20 INFO - 'LANGUAGE': 'en_US:en', 09:16:20 INFO - 'LOGNAME': 'cltbld', 09:16:20 INFO - 'MAIL': '/var/mail/cltbld', 09:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:20 INFO - 'MOZ_NO_REMOTE': '1', 09:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:20 INFO - 'NO_EM_RESTART': '1', 09:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:20 INFO - 'PWD': '/builds/slave/test', 09:16:20 INFO - 'SHELL': '/bin/bash', 09:16:20 INFO - 'SHLVL': '1', 09:16:20 INFO - 'TERM': 'linux', 09:16:20 INFO - 'TMOUT': '86400', 09:16:20 INFO - 'USER': 'cltbld', 09:16:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:20 INFO - '_': '/tools/buildbot/bin/python'} 09:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:20 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:23 INFO - warning: no files found matching '*.txt' 09:16:23 INFO - no previously-included directories found matching 'build' 09:16:23 INFO - no previously-included directories found matching 'dist' 09:16:23 INFO - no previously-included directories found matching '.git*' 09:16:23 INFO - Installing collected packages: jsonschema, functools32 09:16:23 INFO - Running setup.py install for functools32 09:16:23 INFO - warning: no files found matching '*.txt' 09:16:23 INFO - no previously-included directories found matching 'build' 09:16:23 INFO - no previously-included directories found matching 'dist' 09:16:23 INFO - no previously-included directories found matching '.git*' 09:16:23 INFO - Successfully installed jsonschema functools32 09:16:23 INFO - Cleaning up... 09:16:23 INFO - Return code: 0 09:16:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:16:23 INFO - Using env: {'DISPLAY': ':0', 09:16:23 INFO - 'HOME': '/home/cltbld', 09:16:23 INFO - 'LANG': 'en_US.UTF-8', 09:16:23 INFO - 'LANGUAGE': 'en_US:en', 09:16:23 INFO - 'LOGNAME': 'cltbld', 09:16:23 INFO - 'MAIL': '/var/mail/cltbld', 09:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:23 INFO - 'MOZ_NO_REMOTE': '1', 09:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:23 INFO - 'NO_EM_RESTART': '1', 09:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:23 INFO - 'PWD': '/builds/slave/test', 09:16:23 INFO - 'SHELL': '/bin/bash', 09:16:23 INFO - 'SHLVL': '1', 09:16:23 INFO - 'TERM': 'linux', 09:16:23 INFO - 'TMOUT': '86400', 09:16:23 INFO - 'USER': 'cltbld', 09:16:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:23 INFO - '_': '/tools/buildbot/bin/python'} 09:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:23 INFO - Cleaning up... 09:16:23 INFO - Return code: 0 09:16:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:23 INFO - Using env: {'DISPLAY': ':0', 09:16:23 INFO - 'HOME': '/home/cltbld', 09:16:23 INFO - 'LANG': 'en_US.UTF-8', 09:16:23 INFO - 'LANGUAGE': 'en_US:en', 09:16:23 INFO - 'LOGNAME': 'cltbld', 09:16:23 INFO - 'MAIL': '/var/mail/cltbld', 09:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:23 INFO - 'MOZ_NO_REMOTE': '1', 09:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:23 INFO - 'NO_EM_RESTART': '1', 09:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:23 INFO - 'PWD': '/builds/slave/test', 09:16:23 INFO - 'SHELL': '/bin/bash', 09:16:23 INFO - 'SHLVL': '1', 09:16:23 INFO - 'TERM': 'linux', 09:16:23 INFO - 'TMOUT': '86400', 09:16:23 INFO - 'USER': 'cltbld', 09:16:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:23 INFO - '_': '/tools/buildbot/bin/python'} 09:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:26 INFO - Downloading docopt-0.6.1.tar.gz 09:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:26 INFO - Running setup.py install for blobuploader 09:16:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:26 INFO - Running setup.py install for requests 09:16:26 INFO - Running setup.py install for docopt 09:16:27 INFO - Successfully installed blobuploader requests docopt 09:16:27 INFO - Cleaning up... 09:16:27 INFO - Return code: 0 09:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 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 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:27 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 09:16:27 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 09:16:27 INFO - Using env: {'DISPLAY': ':0', 09:16:27 INFO - 'HOME': '/home/cltbld', 09:16:27 INFO - 'LANG': 'en_US.UTF-8', 09:16:27 INFO - 'LANGUAGE': 'en_US:en', 09:16:27 INFO - 'LOGNAME': 'cltbld', 09:16:27 INFO - 'MAIL': '/var/mail/cltbld', 09:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:27 INFO - 'MOZ_NO_REMOTE': '1', 09:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:27 INFO - 'NO_EM_RESTART': '1', 09:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:27 INFO - 'PWD': '/builds/slave/test', 09:16:27 INFO - 'SHELL': '/bin/bash', 09:16:27 INFO - 'SHLVL': '1', 09:16:27 INFO - 'TERM': 'linux', 09:16:27 INFO - 'TMOUT': '86400', 09:16:27 INFO - 'USER': 'cltbld', 09:16:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:27 INFO - '_': '/tools/buildbot/bin/python'} 09:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:27 INFO - Running setup.py (path:/tmp/pip-hlea38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:27 INFO - Running setup.py (path:/tmp/pip-h_ayvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:27 INFO - Running setup.py (path:/tmp/pip-p6jdd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:27 INFO - Running setup.py (path:/tmp/pip-YmwfK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:27 INFO - Running setup.py (path:/tmp/pip-qFXXiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:27 INFO - Running setup.py (path:/tmp/pip-Myehn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:27 INFO - Running setup.py (path:/tmp/pip-jmniYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:27 INFO - Running setup.py (path:/tmp/pip-9rtsAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:27 INFO - Running setup.py (path:/tmp/pip-FmZhPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:27 INFO - Running setup.py (path:/tmp/pip-YmfKUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:28 INFO - Running setup.py (path:/tmp/pip-2KEkSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:28 INFO - Running setup.py (path:/tmp/pip-wTvBfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:28 INFO - Running setup.py (path:/tmp/pip-COcc1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:28 INFO - Running setup.py (path:/tmp/pip-8tdvKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:28 INFO - Running setup.py (path:/tmp/pip-PIC1hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:28 INFO - Running setup.py (path:/tmp/pip-s7Nw2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:28 INFO - Running setup.py (path:/tmp/pip-X_ICbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:28 INFO - Running setup.py install for manifestparser 09:16:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:28 INFO - Running setup.py install for mozcrash 09:16:28 INFO - Running setup.py install for mozdebug 09:16:28 INFO - Running setup.py install for mozdevice 09:16:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:28 INFO - Running setup.py install for mozfile 09:16:29 INFO - Running setup.py install for mozhttpd 09:16:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for mozinfo 09:16:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for mozInstall 09:16:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for mozleak 09:16:29 INFO - Running setup.py install for mozlog 09:16:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for moznetwork 09:16:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for mozprocess 09:16:29 INFO - Running setup.py install for mozprofile 09:16:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:29 INFO - Running setup.py install for mozrunner 09:16:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:30 INFO - Running setup.py install for mozscreenshot 09:16:30 INFO - Running setup.py install for moztest 09:16:30 INFO - Running setup.py install for mozversion 09:16:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:30 INFO - Cleaning up... 09:16:30 INFO - Return code: 0 09:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:30 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 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:30 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 09:16:30 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 09:16:30 INFO - Using env: {'DISPLAY': ':0', 09:16:30 INFO - 'HOME': '/home/cltbld', 09:16:30 INFO - 'LANG': 'en_US.UTF-8', 09:16:30 INFO - 'LANGUAGE': 'en_US:en', 09:16:30 INFO - 'LOGNAME': 'cltbld', 09:16:30 INFO - 'MAIL': '/var/mail/cltbld', 09:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:30 INFO - 'MOZ_NO_REMOTE': '1', 09:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:30 INFO - 'NO_EM_RESTART': '1', 09:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:30 INFO - 'PWD': '/builds/slave/test', 09:16:30 INFO - 'SHELL': '/bin/bash', 09:16:30 INFO - 'SHLVL': '1', 09:16:30 INFO - 'TERM': 'linux', 09:16:30 INFO - 'TMOUT': '86400', 09:16:30 INFO - 'USER': 'cltbld', 09:16:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:30 INFO - '_': '/tools/buildbot/bin/python'} 09:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:30 INFO - Running setup.py (path:/tmp/pip-gJQdDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:30 INFO - Running setup.py (path:/tmp/pip-EBwpod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:30 INFO - Running setup.py (path:/tmp/pip-W2H2F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:30 INFO - Running setup.py (path:/tmp/pip-yCrV7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:30 INFO - Running setup.py (path:/tmp/pip-CUlOgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:30 INFO - Running setup.py (path:/tmp/pip-9wnYoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:31 INFO - Running setup.py (path:/tmp/pip-aAwHxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:31 INFO - Running setup.py (path:/tmp/pip-wtAfoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:31 INFO - Running setup.py (path:/tmp/pip-lpte8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:31 INFO - Running setup.py (path:/tmp/pip-GfDNu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:31 INFO - Running setup.py (path:/tmp/pip-qjLJsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:31 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:31 INFO - Running setup.py (path:/tmp/pip-Yl1AQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:31 INFO - Running setup.py (path:/tmp/pip-PiRfF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:31 INFO - Running setup.py (path:/tmp/pip-ZUNWN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:31 INFO - Running setup.py (path:/tmp/pip-tRkn3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:31 INFO - Running setup.py (path:/tmp/pip-NxwziI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:31 INFO - Running setup.py (path:/tmp/pip-qXRoh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:33 INFO - Downloading blessings-1.6.tar.gz 09:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:33 INFO - Installing collected packages: blessings 09:16:33 INFO - Running setup.py install for blessings 09:16:33 INFO - Successfully installed blessings 09:16:33 INFO - Cleaning up... 09:16:33 INFO - Return code: 0 09:16:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:34 INFO - Reading from file tmpfile_stdout 09:16:34 INFO - Current package versions: 09:16:34 INFO - argparse == 1.2.1 09:16:34 INFO - blessings == 1.6 09:16:34 INFO - blobuploader == 1.2.4 09:16:34 INFO - docopt == 0.6.1 09:16:34 INFO - functools32 == 3.2.3-2 09:16:34 INFO - jsonschema == 2.5.1 09:16:34 INFO - manifestparser == 1.1 09:16:34 INFO - mozInstall == 1.12 09:16:34 INFO - mozcrash == 0.17 09:16:34 INFO - mozdebug == 0.1 09:16:34 INFO - mozdevice == 0.48 09:16:34 INFO - mozfile == 1.2 09:16:34 INFO - mozhttpd == 0.7 09:16:34 INFO - mozinfo == 0.9 09:16:34 INFO - mozleak == 0.1 09:16:34 INFO - mozlog == 3.4 09:16:34 INFO - moznetwork == 0.27 09:16:34 INFO - mozprocess == 0.23 09:16:34 INFO - mozprofile == 0.28 09:16:34 INFO - mozrunner == 6.12 09:16:34 INFO - mozscreenshot == 0.1 09:16:34 INFO - mozsystemmonitor == 0.3 09:16:34 INFO - moztest == 0.7 09:16:34 INFO - mozversion == 1.4 09:16:34 INFO - psutil == 3.1.1 09:16:34 INFO - requests == 1.2.3 09:16:34 INFO - wsgiref == 0.1.2 09:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 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 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:34 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 09:16:34 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 09:16:34 INFO - Using env: {'DISPLAY': ':0', 09:16:34 INFO - 'HOME': '/home/cltbld', 09:16:34 INFO - 'LANG': 'en_US.UTF-8', 09:16:34 INFO - 'LANGUAGE': 'en_US:en', 09:16:34 INFO - 'LOGNAME': 'cltbld', 09:16:34 INFO - 'MAIL': '/var/mail/cltbld', 09:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:34 INFO - 'MOZ_NO_REMOTE': '1', 09:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:34 INFO - 'NO_EM_RESTART': '1', 09:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:34 INFO - 'PWD': '/builds/slave/test', 09:16:34 INFO - 'SHELL': '/bin/bash', 09:16:34 INFO - 'SHLVL': '1', 09:16:34 INFO - 'TERM': 'linux', 09:16:34 INFO - 'TMOUT': '86400', 09:16:34 INFO - 'USER': 'cltbld', 09:16:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:34 INFO - '_': '/tools/buildbot/bin/python'} 09:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:34 INFO - Cleaning up... 09:16:34 INFO - Return code: 0 09:16:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f933a920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', '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 09:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:34 INFO - Using env: {'DISPLAY': ':0', 09:16:34 INFO - 'HOME': '/home/cltbld', 09:16:34 INFO - 'LANG': 'en_US.UTF-8', 09:16:34 INFO - 'LANGUAGE': 'en_US:en', 09:16:34 INFO - 'LOGNAME': 'cltbld', 09:16:34 INFO - 'MAIL': '/var/mail/cltbld', 09:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:34 INFO - 'MOZ_NO_REMOTE': '1', 09:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:34 INFO - 'NO_EM_RESTART': '1', 09:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:34 INFO - 'PWD': '/builds/slave/test', 09:16:34 INFO - 'SHELL': '/bin/bash', 09:16:34 INFO - 'SHLVL': '1', 09:16:34 INFO - 'TERM': 'linux', 09:16:34 INFO - 'TMOUT': '86400', 09:16:34 INFO - 'USER': 'cltbld', 09:16:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:34 INFO - '_': '/tools/buildbot/bin/python'} 09:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:34 INFO - Cleaning up... 09:16:34 INFO - Return code: 0 09:16:34 INFO - Running post-action listener: _resource_record_post_action 09:16:34 INFO - Running post-action listener: _start_resource_monitoring 09:16:34 INFO - Starting resource monitoring. 09:16:34 INFO - [mozharness: 2016-10-20 16:16:34.667042Z] Finished create-virtualenv step (success) 09:16:34 INFO - [mozharness: 2016-10-20 16:16:34.667543Z] Running install step. 09:16:34 INFO - Running pre-action listener: _resource_record_pre_action 09:16:34 INFO - Running main action method: install 09:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:34 INFO - Reading from file tmpfile_stdout 09:16:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:34 INFO - Reading from file tmpfile_stdout 09:16:34 INFO - Output received: 09:16:34 INFO - Usage: mozinstall [options] installer 09:16:34 INFO - Options: 09:16:34 INFO - -h, --help show this help message and exit 09:16:34 INFO - -d DEST, --destination=DEST 09:16:34 INFO - Directory to install application into. [default: 09:16:34 INFO - "/builds/slave/test"] 09:16:34 INFO - --app=APP Application being installed. [default: firefox] 09:16:34 INFO - mkdir: /builds/slave/test/build/application 09:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:16:51 INFO - Reading from file tmpfile_stdout 09:16:51 INFO - Output received: 09:16:51 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:51 INFO - Running post-action listener: _resource_record_post_action 09:16:51 INFO - [mozharness: 2016-10-20 16:16:51.488454Z] Finished install step (success) 09:16:51 INFO - [mozharness: 2016-10-20 16:16:51.488698Z] Running run-tests step. 09:16:51 INFO - Running pre-action listener: _resource_record_pre_action 09:16:51 INFO - Running main action method: run_tests 09:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:51 INFO - Python 2.7.3 09:16:51 INFO - Return code: 0 09:16:51 INFO - grabbing minidump binary from tooltool 09:16:51 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')]} 09:16:51 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 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:51 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 09:16:51 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 09:16:51 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 09:16:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:51 INFO - Return code: 0 09:16:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:16:51 INFO - Using env: {'DISPLAY': ':0', 09:16:51 INFO - 'HOME': '/home/cltbld', 09:16:51 INFO - 'LANG': 'en_US.UTF-8', 09:16:51 INFO - 'LANGUAGE': 'en_US:en', 09:16:51 INFO - 'LOGNAME': 'cltbld', 09:16:51 INFO - 'MAIL': '/var/mail/cltbld', 09:16:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:51 INFO - 'MOZ_NO_REMOTE': '1', 09:16:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:51 INFO - 'NO_EM_RESTART': '1', 09:16:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:51 INFO - 'PWD': '/builds/slave/test', 09:16:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:51 INFO - 'SHELL': '/bin/bash', 09:16:51 INFO - 'SHLVL': '1', 09:16:51 INFO - 'TERM': 'linux', 09:16:51 INFO - 'TMOUT': '86400', 09:16:51 INFO - 'USER': 'cltbld', 09:16:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086', 09:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:51 INFO - '_': '/tools/buildbot/bin/python'} 09:16:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:16:51 INFO - mozversion application_buildid: 20161020074550 09:16:51 INFO - mozversion application_changeset: c2753c9ba68ebd62aa8c086e7f36835ebd064044 09:16:51 INFO - mozversion application_display_name: Nightly 09:16:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:51 INFO - mozversion application_name: Firefox 09:16:51 INFO - mozversion application_remotingname: firefox 09:16:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:51 INFO - mozversion application_vendor: Mozilla 09:16:51 INFO - mozversion application_version: 52.0a1 09:16:51 INFO - mozversion platform_buildid: 20161020074550 09:16:51 INFO - mozversion platform_changeset: c2753c9ba68ebd62aa8c086e7f36835ebd064044 09:16:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:51 INFO - mozversion platform_version: 52.0a1 09:16:51 INFO - using testdate: 1476980211 09:16:51 INFO - actual date: 1476980211 09:16:51 INFO - starting webserver on 'localhost:54772' 09:16:51 INFO - SUITE-START | Running 2 tests 09:16:51 INFO - TEST-START | dromaeo_css 09:16:51 INFO - operating with platform_type : linux_ 09:16:51 INFO - Initialising browser for dromaeo_css test... 09:16:51 INFO - TEST-INFO | started process 25211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2eP1c/profile http://localhost:54772/getInfo.html) 09:16:56 INFO - PROCESS | 25211 | __metrics Screen width/height:1600/1200 09:16:56 INFO - PROCESS | 25211 | colorDepth:24 09:16:56 INFO - PROCESS | 25211 | Browser inner width/height: 1024/697 09:16:56 INFO - PROCESS | 25211 | __metrics 09:16:57 ERROR - PROCESS | 25211 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 09:16:58 INFO - TEST-INFO | 25211: exit 0 09:16:58 INFO - Browser initialized. 09:16:58 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:58 INFO - TEST-INFO | started process 25334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2eP1c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:10 INFO - PROCESS | 25334 | RSS: Main: 183357440 09:17:10 INFO - PROCESS | 25334 | 09:18:00 INFO - PROCESS | 25334 | 1476980280167 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] 09:20:14 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54772/tests/dromaeo/cssquery-ext.html) 09:20:15 INFO - PROCESS | 25334 | RSS: Main: 193961984 09:20:15 INFO - PROCESS | 25334 | 09:23:17 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-ext.html (next: http://localhost:54772/tests/dromaeo/cssquery-jquery.html) 09:23:18 INFO - PROCESS | 25334 | RSS: Main: 195047424 09:23:18 INFO - PROCESS | 25334 | 09:26:20 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54772/tests/dromaeo/cssquery-mootools.html) 09:26:21 INFO - PROCESS | 25334 | RSS: Main: 197271552 09:26:21 INFO - PROCESS | 25334 | 09:29:23 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54772/tests/dromaeo/cssquery-prototype.html) 09:29:23 INFO - PROCESS | 25334 | RSS: Main: 194080768 09:29:23 INFO - PROCESS | 25334 | 09:32:26 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54772/tests/dromaeo/cssquery-yui.html) 09:32:27 INFO - PROCESS | 25334 | RSS: Main: 197087232 09:32:27 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | Cycle 1(1): loaded http://localhost:54772/tests/dromaeo/cssquery-yui.html (next: http://localhost:54772/tests/dromaeo/cssquery-dojo.html) 09:35:30 INFO - PROCESS | 25334 | RSS: Main: 197476352 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | __start_tp_report 09:35:30 INFO - PROCESS | 25334 | _x_x_mozilla_page_load 09:35:30 INFO - PROCESS | 25334 | _x_x_mozilla_page_load_details 09:35:30 INFO - PROCESS | 25334 | |i|pagename|runs| 09:35:30 INFO - PROCESS | 25334 | |0;dojo.html;2654.416028473736;2678;2685.1810197889636;2694.312950197699;2699.8245114067577;4753.405824271966;4796.7601619919;4802.087603355369;4838.201696720042;4851.393575803025;4747.572718455338;4813.90372192556;4822.035592881429;4827.78274977626;4921.680090794105;4347.456567929009;4422.535633758457;4429.6899217054815;4468.865934021985;4533.433320834895;4117.197146556423;4580.038191979688;4581.40441742573;4605.907881842361;4617.261238201889;4318.1363727254675;4499.212637788374;4515.390422292981;4538;4616.238320677085;4338.913221735579;4342.826286948518;4365.716228445172;4389.670774691911;4408.272635015219;4324.805383757707;4330.220560299145;4365.2142614329405;4392.758398288093;4394.121175764828;4745.905081898342;4780.521947805227;4791.137595232856;4791.161546729309;4836.975815120902;5105.463926287724;5170.6122040847085;5177.663451875616;5185.351831021122;5209.687418754849;5176.327077479941;5176.430592634807;5193.324867767166;5193.428722840485;5229.712365819878;4781.952180478151;4793.784279707422;4823.1800593899125;4823.445303790038;4824.855254342376;5171.948280517222;5173.1464308388695;5198.714070726146;5214.921776173284;5289.545375021899;5004.524570165829;5012.298278241049;5013.172826483589;5013.896942672606;5056.82301119459;5036.269740887551;5051.166557518042;5105.2086926526445;5115.437301896788;5116.437191908887;5068.113080210948;5124.461931497139;5142.51146141116;5178.6116041297055;5221.242919776611;5121.615878809104;5127.230915362651;5127.846164615067;5133;5136.794528218829;4384.6711496637245;4408.669349798778;4409.867703968886;4462.419885414875;4462.620677242406;3770.3967365221984;3796.981015094907;3802.372608519563;3833.4441505981476;3878.398848178537;4430.180416622935;4439.866803995886;4447.355133505624;4469.620082292977;4496.595306422438;5172.120739474299;5191.922121168185;5217.087009773274;5228.058949389147;5293.258943747878;4354.8911277217685;4358.607725304738;4401.273789824643;4432.423784907941;4433.977830110829;4686.461056978491;4695.24876019842;4703.976480117578;4704.717716936994;4714.929276060861;4844.903101937942;4844.927326090182;4848.321235027099;4848.393950756155;4856.028794241095;5213.165893457029;5263.36839579253;5264.763085661231;5318.7340632967425;5333.813316533902;4888.853334399973;4894.828680996148;4899.706017638953;4908.435529914105;4958.752062396794;5023.799048038184;5070.087384270867;5164.896702066013;5174;5178.275041494118;5130.435652078343;5162.845114646567;5182.844514664566;5205.6616319939085;5216.6348355616265;4927.778249978688;4997.175466048061;5005.624578156726;5048.848534543969;5062.265971434195;4990.3762029746285;5007.349044624321;5016.4231113420965;5023.397192336943;5042.571381432619;4819.7108173509705;4894.119058569349;4921.212605983025;4925.753712314442;4928.753562321941;5145.639805213599;5147.536721695065;5160.045391602565;5189.6107791915;5191.195364718475;5007.349044624176;5038.746220940299;5041.117804384145;5056.191009438472;5063.594912406925 09:35:30 INFO - PROCESS | 25334 | |1;ext.html;530.9256704061432;546.469924173552;554.2600628161405;564.6273459516717;567.8835838653076;38237.23525529491;40406.59593404065;40425.59574404255;43713.34429983553;43755.34366984498;40116.799416002956;40613;40659.39010914831;40686;40747.38878916819;7486.02681651386;7495.812604684899;7547.50941188821;7595.772126836204;7596.810079747996;7652.540847549137;7717.6912923483;7725.536467811921;7735.806604834868;7757.49576277543;7783.844323113534;7810.9609451952665;7813.9609301953415;7822.960885195566;7827.569483678395;7728.227177282283;7742.61286935651;7752.069751629812;7766.57283849388;7773.144954055049;7628.351590114847;7672.117706463772;7676.731314403969;7677.30904218623;7683.270089341504;38443.61556384428;38655.22689546221;38723;38736.418953715714;38748;2777.125205560242;3121.5473756305437;3218.0185043561705;3516.82415879205;3531.9117022074397;27770.861145694143;28022.299442513897;28208.294792630142;28309.292267693265;28365.574516382272;3406.0823607571538;3503.807290599016;3507.0530956641564;3541.628129046439;3548.1484443733316;238301;238714;238771;238837;239258;50002;50120.24819627708;50355.24467132996;50472;50555.49444505582;53523.19715204275;54073;54116.72941635267;54207;54310.45689543054;12285.815712764315;12395.256284622952;12457.875421245672;12464.127511074137;12529.43617537213;8995.100489950952;9037.909620903707;9084.137006984325;9089.590968406437;9109.316801239933;13299.468021279234;15417.845821541865;15424.922875385551;15570.221488925508;15594.454194103151;2913.6503619565788;5425.48758953201;5606.719664016783;5860.267466566679;5917.970410148007;751.5227830327672;830.2693629605908;837.351052933981;918.3342076994126;928.6192661009089;25580.488390232462;26394.472110557683;27051.421777469455;27526.17421477359;27595.172144835688;903.4714691905309;965.8164948659733;980.774421882971;982.150439869522;985.9507024648739;13502.864971350356;14353.497627582985;14353.856461435253;14431;14612.853871461362;351877;356467;359891;360286;360816;50399.24401133986;50914;50964.74517627388;51095;51214.74392628013;1119.8096323625002;1147.5008371358485;1152.7924973504682;1161.4599211366585;1161.4831400027076;25319.873400632878;26142.73857261403;27278.454430911668;27639.447211056067;27734;41958;42293;42354.78822605991;42389;42496.78751606346;302133;304774;305440;305775;305887;22757.772422275564;22783.430414239778;22976.19583314576;22986.655200171677;23049.539009220058;40147.59852401556;40452.79773601113;40464;41650.37524437075;41870.371944421466;35458.822705886305;35581.82209088938;35803.641963580034;36184.45723314205;36560.45159322665;34866;35108.12229694278;35316.47025294674;35412.29175416426;35755;34304;34538.654613453546;34614.65385346215;35624.46563301604;35662.28675426425;29257.85371073131;31591.526127107652;31720.841395792875;31839.36321273608;31842.84078579592;24227.39431514226;24840.37899052538;25827.612585811603;26106.347341316618;27019.324516887234 09:35:30 INFO - PROCESS | 25334 | |2;jquery.html;356.6522640425587;358.1404628890662;370.1191165027235;370.32231017238456;389.2914894891299;15242.314095865684;15600;16802.83197168028;16882;16941.152942352895;14558.199299038548;14695.559133226021;14979.625509362271;15061.17163556004;15098.16960067196;4919.139150648631;5094.1594636884865;5181.455947125554;5215;5225.869353266161;5149.897002059956;5252.579793616502;5258.158694608864;5261.263423120766;5276.683398996072;5022.497750224985;5110.744462776865;5114.462981386938;5121.385433747955;5121.462246464123;5103.311053007834;5117.592662017956;5179.378474583036;5180.430152683201;5204.245384419257;4392.450943632046;4538.7276763393975;4547.386102876136;4551.271796512575;4567.378580603871;19601;19609.117589708498;19981;20035.599288014302;20063.39809805708;1831.5146486181172;1956.8923709195988;2072.4093633314433;2417.4560723836994;2454.202384225116;13067;13142.277174755385;13163.144395614254;13203.2738199399;13583.592492225249;1655.6026553627044;1661.7590449384772;1708.6326439815375;1721.6900957827586;1732.904690242049;42754;65105.743189421715;66466.66766666184;69400;69460.95808562926;9315.161635452841;9345.859812102688;9361.391509551993;9412.670556530626;9431.821022372204;12842.550510732266;12914.870851291555;13020.218786872818;13045.739085218242;13056.738865222642;6584.604923704593;6589.670516474253;6746.662666866637;6772.424343930821;6920.169579650475;6123.785667501706;6193.535484838655;6278.6860656966965;6397.168368112209;6403.679816009181;5885.646861188342;5983.820485385445;6004.729787159501;6082.118092876596;6100.69496525172;1747.2254199869299;1792.453301742981;1795.6588248232795;1796.1499655355005;1807.493901707524;782.2685788787502;848.295914391054;876.3602570123718;906.845836207833;924.6209054287845;15764.211789410483;16389.83610163907;16630.251638676287;16996;17512.124393780516;369.64329422107795;383.31769450377817;384.11269966377756;823.56762699582;888.8089060851947;5060.645754797129;5455.5908306877145;5557.3331200256225;5588.413216612197;5683.204351390808;351766;353684;357674;358999;360165;74894;76058;76118;77174.61412692901;77809;404.3045960947166;413.3242149086266;414.08693830104545;414.22539850479194;414.9585041495826;9788.706338809847;9911.10800028001;9981.452874804418;10037.34757240777;10344.741381465523;36185;36288.81855590705;37205;37544.249115018094;37761;46219;47012.52987470081;47333.7633311845;51176;52905.47094529006;7241;7426.888596670946;7473.850522989401;7537.359324457482;7860.646270917937;10888.836667450152;11913.22564033335;11934.582289619822;11994.580189693319;12243.755124897274;4785.042991401664;6803.761868334783;10154.44150571696;10420.739481513023;10577.153827693919;9569.521523923915;9736.659216927657;9795.706128815862;9883.209343252667;10040.397576145455;4839.95160048395;5068.518490743373;9830.950845245728;10325.277230594087;10667.413292269;7384.593847338448;7461.179270280156;7557.395408367208;7647.082350118021;7776.144624091232;10168.491575421347;10428.27002109845;10477.266591338534;10647.680569582924;10960.835587466354 09:35:30 INFO - PROCESS | 25334 | |3;mootools.html;1374.491438167878;1416.0370947755528;1506.6082818467196;1656.2629629814721;1717.0813614716121;6584.176977877765;6817.965910170455;7071.222165561784;7689.154193038768;7724.845503089935;7289.088863892013;7617.276358745924;7627.046619172604;7786.182450842665;7800.3759699224065;2072.865263757855;2100.9894950525227;2110.155937624947;2111.767705552388;2112.2923820520145;2071.1818831561523;2082.760482544504;2093.696414019966;2141.753698324697;2142.6036183306137;2076.0553947953645;2115.7038014677955;2115.9259425920095;2117.2907076129513;2118.5762847430574;2014.979850201494;2020.8888511131881;2031.8520036179584;2032.0246281784825;2039.6328660841043;2026.929057482981;2032.6849338352579;2061.1034200122995;2066.8243199328076;2067.235123004498;7605.201453847377;7676.270754278335;7677;7738.110117336522;7807.180246074137;4224.577542245782;4337.306031035051;4338.414314067592;4340.47914250292;4350.521442641307;2893.85530723463;2912.563115532666;2944.6319210098736;3023.5918151049545;3093.0875391759487;870.3211495033884;920.1396694090979;923.8568021956607;947.4220725357526;1696.8048674402355;9881.604735810559;10302.587896484132;10317.380957142595;10355.326903751233;10355.89644103557;3661.7802931823644;3854.768713877176;3918.1380096378753;3943.8225279862477;4012.398140278923;7920.564368959647;7965.641546130438;7975.641096150687;7983.081945576217;7984.321332686671;4305.590968857953;4323.092150648336;4327.091310824699;4327.17783621111;4331.97834010828;3442.982785086109;3547.0068380853404;3835.5972622874197;4048.716589838742;4066.694997875112;3516.6659167379057;3663.413853783435;3673.7061035117663;3692.9076773080888;3733.178700685845;1145.9828102578467;1154.653603918821;1179.3101035893926;1183.207251141737;1200.6158029430499;799.4124318625805;834.3200291762315;853.2619284319144;862.6247582301719;882.6601758323092;4930.852074437773;5046.142155833517;5172.818951336685;5183.922241166386;5352.918960822157;791.6754130806341;850.1923172985688;853.9573021348908;874.8731433942042;891.0999890110905;3458.239187378773;3528.188516641187;3528.2590655962535;3537.7346698997676;3660.9816950915074;9010.504422256708;9341.953290233505;9477.905220947703;9527.237820974306;9607.231421486264;9442.716718498456;9444.90555094454;9466.810663786686;9483.051694830461;9523.523823808782;7183.245759195313;7244.275572442713;7286.562806231643;7323.670434830446;7388.519746216479;4987.60099192071;5219.791208351623;5297.231901374356;5334.626576139633;5359.088954877758;8429.536375499407;8518.957405212934;8538.701145460127;8549.102344254012;8614.18165274298;8434.198751118634;8564.57177141128;8649.61076751535;8717.302615790595;8791.780205494659;5938.584299099021;6023.30731965812;6664.233613134552;6772.55978361405;6817.965910170417;7262.31008054234;7430.368418684472;7476.401887849068;7496.812579685551;7532.096148462219;6697;6707.3628005339415;6797.626130562867;6976.825579360557;6993.860122797617;6649.168853893263;6737.095866393708;6757.93242067573;6893.517453778188;6937.89593156093;5957.463828255478;6049.606775559574;6059.969700151471;6063.969680151571;6073.149759033827;4199.265128602544;4325.697201195886;4400.867973960786;4406.669499787465;4423.358613001033;4473.150101480708;4485.596296333215;4527.909441811211;4617.53824617549;4631.282151266559 09:35:30 INFO - PROCESS | 25334 | |4;prototype.html;290.9839958802266;292.6254394375199;296.6588423313191;296.9502807575222;299.9850007499625;5107.463716309785;5137.255098010795;5140.5373516383515;5148.716820574867;5152.40747314059;4981.427135879375;4988.4762099979525;5011.899762004758;5013.899722005567;5041.798328066882;3690.317291301118;3724.404095344745;3808.885733427988;3833.5624140947143;3866;3849.788261645608;3853.556840963283;3860.8841734748003;3865.323568375523;3880.5343358796986;3838.2131663009154;3847.941816000608;3848.461215429842;3853.2293541291715;3859.536855577335;3726.9627303727157;3805.8744580321213;3812.8474861005525;3861.575226725058;3875.379939209713;3325.9501107483406;3344.8996530104137;3347.548081009057;3347.782394144373;3353.983230083834;4810;4812.37439132914;4831.4202295724735;4846.830360937351;4860.198067318888;4383.956160438387;4405.801738921757;4423.5576442355505;4433.357163211316;4440.4671439427475;5060.292743382272;5193.9740301298625;5216.956858434705;5217.16525355945;5235;3651.8174091295327;3669.1560940983454;3676.7793932363875;3678.797666128362;3680.576733675608;5477.589180811416;5483.616146869721;5506.201600767907;5507.752151153208;5507.917381239245;3503.4394496880377;3715.981420092882;3724.1434470072036;3738.5700644425697;3747.269282489888;3766.077311058808;3767.0411386079086;3774.8490060397276;3775.962240377616;3786.73492855503;4388.648908087345;4392.07766369066;4392.912141757147;4397.934030989538;4408.7875834145225;5145.331106956071;5281.9207711884355;5312.76092575835;5337.5463085637375;5354.491323324278;1308.2281453942219;1309.7315050414643;1311.8229039079793;1314.3888092037248;1321.4185758266524;776.9844603107906;814.7981726952697;817.5380909785952;822.5147163173756;825.8885050518223;4458.35353873693;4610.561996610317;4631.791569379386;4669.789859456333;4670.906581868411;5541.810984661036;5549.944500555023;5562.638428502134;5575.69333686643;5578;4539.7301349325335;4642;4647.790849411785;4652.232381657056;4714.929276060861;2840.5881147233536;2883.2071180425132;2898.1595337351932;2905.389868127717;2935.500964835983;5112.389597276846;5123.795048198105;5132.615053870974;5148.382194136728;5153.845384638467;5291.497307755757;5577.44225577439;5581.581381396411;5612.943870561324;5624.29696287964;5113.41195762492;5118.232265160255;5118.641695081308;5137.255098010693;5159.200323949719;5484.2578710644675;5531.336239651107;5533.253010843485;5542.722863856871;5554.750036248298;5171.974140129426;5389;5397.757100930389;5420.376656684532;5424.159255315432;5100.566451851634;5111.718855462986;5112.284280200849;5119.385673719177;5142.794288228429;3748.6626203641804;3749.118957045038;3774.1130834254477;3793.639604237593;3806.5051543299196;5393.7033463159905;5431.918521222264;5445.156000819879;5489.423610520837;5541.750621221974;5263.421023687315;5271.551918087006;5278.36659600835;5280.656757310762;5305.522502974596;5303;5304.885973945515;5311.601629877852;5373.462653734751;5383.81156659515;4817.759112044454;5127.4103478099005;5136.666116702402;5156.035279714104;5165.133350990236;5030.063425581251;5160.48395160481;5166.715830629351;5283.339582552181;5316.787328506816;5175.249588809676;5182.40402353719;5211.843644690665;5242.633015688865;5260.921086183634 09:35:30 INFO - PROCESS | 25334 | |5;yui.html;625.859181684121;639.68015992004;642.38331202046;666.0375757031092;724.4638967164296;12979.61061168164;13636.113652612574;13943.930280348597;13961.720765584681;14400.855991440083;14164.575062748108;14212.502562410318;14237.501687440941;14251.4299428023;14281.21453320067;602.6775675013869;634.8000379880345;746.1233051164887;764.1212605503673;784.145281643009;795.1730200591378;814.8370325934807;814.9185081491863;815.5188438821094;816.2816721285291;852.21170417364;854.581255184958;855.1875718067829;855.7946092937681;857.3312816003527;846.5090247656344;847.7329641163014;847.9236868681818;848.7962888906679;850.4599579267148;619.6746707978348;620.2680836612795;620.5283984172016;621.3972446726668;622.6295354264206;14268.643283917881;14401.495947641783;14447.638809029753;14459.493917712934;14480;12367.196132251465;12661.113722039461;12766;12929.806052909214;13251.871268675288;10507.159427245802;10550.472476376228;10786.892131078666;10919.727006824813;11359.659210223625;3284.178955261185;3293.6212335581235;3342.598888133415;3355.13789846635;3381.1547113221695;60077.098843517386;60135.39864601342;60438.39561604416;61095.694521527104;61469;9669.951650241705;9821.214302855755;9856.260780441495;9914.851277230848;9982.051705088004;18267.72598411025;18450.815491845176;18454.35409760652;18479.907600461913;18810.905945470186;6135.07973803933;6335.841603959938;6617.4706023518;6678.121306623431;6846.965765171142;3171.302313491028;3271.787333823294;3550.822458877046;3598.478220658042;3659.213269147146;2912.8689208985224;2997.2057404787747;3017.4417732719517;3021.1087729119963;3029.0307101727676;483.9346688197119;485.85667228167773;495.91569433196446;501.25063030768507;507.99492005080214;592.926802487499;595.7348979703991;611.3305930006725;613.6318209074609;643.359856942336;7321.450891183076;7329.340359367682;7618;7652.617369131633;7827.25641064098;487.27396179692005;514.2748724298721;517.0202466326366;585.7305639405836;619.5322531488787;3407.727381809449;3666.9633303667156;3670.302642497917;3680.4479328100465;3852.210296889131;68619;82422.58788706138;86448.56775716081;86508.56745716358;86640.56679716561;64245.678771605846;75500.62249688826;75557.62221188859;77720.2227977713;78779;58927.41072589305;65497;66221;67861;68006.65996669985;7651.540907545343;8106.635201416068;8238.382121341043;8279.742363599038;8294.668213271643;38255.808720956215;38696.226075478895;40660.79669601633;40920.38619420651;42219.15561688811;47849.76075119602;48393.75803120962;51516;52896;55987.44012559822;10044;10619;10875.51060202277;11121;11663.825042624538;13010.479580816662;13072.346382681018;13264.204147751167;13317.733645327233;13978.231197284247;11870.347130907883;11992.280463172237;12079.094067944763;12233.327167005544;12247.816282755588;11810.173287869766;11976.520939162336;12300.261984280973;12349.259044457362;12683.936580317408;11047.502862371373;11302.43487825622;11591.072714182677;11864.11019173548;11896.881031189578;9258.583363748783;9515.238780897373;9598.568064436977;9644;9706.951465242912;9163.679271225476;9213.86179207299;9720.805583888425;9781.60873565078;9866.55600497965 09:35:30 INFO - PROCESS | 25334 | __end_tp_report 09:35:30 INFO - PROCESS | 25334 | __start_cc_report 09:35:30 INFO - PROCESS | 25334 | _x_x_mozilla_cycle_collect,329 09:35:30 INFO - PROCESS | 25334 | __end_cc_report 09:35:30 INFO - PROCESS | 25334 | __startTimestamp1476981330487__endTimestamp 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | ------- Summary: start ------- 09:35:30 INFO - PROCESS | 25334 | Number of tests: 6 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#0] dojo.html Cycles:165 Average:4773.50 Median:4894.83 stddev:506.42 (10.3%) stddev-sans-first:479.92 09:35:30 INFO - PROCESS | 25334 | Values: 2654.4 2678.0 2685.2 2694.3 2699.8 4753.4 4796.8 4802.1 4838.2 4851.4 4747.6 4813.9 4822.0 4827.8 4921.7 4347.5 4422.5 4429.7 4468.9 4533.4 4117.2 4580.0 4581.4 4605.9 4617.3 4318.1 4499.2 4515.4 4538.0 4616.2 4338.9 4342.8 4365.7 4389.7 4408.3 4324.8 4330.2 4365.2 4392.8 4394.1 4745.9 4780.5 4791.1 4791.2 4837.0 5105.5 5170.6 5177.7 5185.4 5209.7 5176.3 5176.4 5193.3 5193.4 5229.7 4782.0 4793.8 4823.2 4823.4 4824.9 5171.9 5173.1 5198.7 5214.9 5289.5 5004.5 5012.3 5013.2 5013.9 5056.8 5036.3 5051.2 5105.2 5115.4 5116.4 5068.1 5124.5 5142.5 5178.6 5221.2 5121.6 5127.2 5127.8 5133.0 5136.8 4384.7 4408.7 4409.9 4462.4 4462.6 3770.4 3797.0 3802.4 3833.4 3878.4 4430.2 4439.9 4447.4 4469.6 4496.6 5172.1 5191.9 5217.1 5228.1 5293.3 4354.9 4358.6 4401.3 4432.4 4434.0 4686.5 4695.2 4704.0 4704.7 4714.9 4844.9 4844.9 4848.3 4848.4 4856.0 5213.2 5263.4 5264.8 5318.7 5333.8 4888.9 4894.8 4899.7 4908.4 4958.8 5023.8 5070.1 5164.9 5174.0 5178.3 5130.4 5162.8 5182.8 5205.7 5216.6 4927.8 4997.2 5005.6 5048.8 5062.3 4990.4 5007.3 5016.4 5023.4 5042.6 4819.7 4894.1 4921.2 4925.8 4928.8 5145.6 5147.5 5160.0 5189.6 5191.2 5007.3 5038.7 5041.1 5056.2 5063.6 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#1] ext.html Cycles:180 Average:45357.33 Median:37398.84 stddev:80060.02 (214.1%) stddev-sans-first:80213.86 09:35:30 INFO - PROCESS | 25334 | Values: 530.9 546.5 554.3 564.6 567.9 38237.2 40406.6 40425.6 43713.3 43755.3 40116.8 40613.0 40659.4 40686.0 40747.4 7486.0 7495.8 7547.5 7595.8 7596.8 7652.5 7717.7 7725.5 7735.8 7757.5 7783.8 7811.0 7814.0 7823.0 7827.6 7728.2 7742.6 7752.1 7766.6 7773.1 7628.4 7672.1 7676.7 7677.3 7683.3 38443.6 38655.2 38723.0 38736.4 38748.0 2777.1 3121.5 3218.0 3516.8 3531.9 27770.9 28022.3 28208.3 28309.3 28365.6 3406.1 3503.8 3507.1 3541.6 3548.1 238301.0 238714.0 238771.0 238837.0 239258.0 50002.0 50120.2 50355.2 50472.0 50555.5 53523.2 54073.0 54116.7 54207.0 54310.5 12285.8 12395.3 12457.9 12464.1 12529.4 8995.1 9037.9 9084.1 9089.6 9109.3 13299.5 15417.8 15424.9 15570.2 15594.5 2913.7 5425.5 5606.7 5860.3 5918.0 751.5 830.3 837.4 918.3 928.6 25580.5 26394.5 27051.4 27526.2 27595.2 903.5 965.8 980.8 982.2 986.0 13502.9 14353.5 14353.9 14431.0 14612.9 351877.0 356467.0 359891.0 360286.0 360816.0 50399.2 50914.0 50964.7 51095.0 51214.7 1119.8 1147.5 1152.8 1161.5 1161.5 25319.9 26142.7 27278.5 27639.4 27734.0 41958.0 42293.0 42354.8 42389.0 42496.8 302133.0 304774.0 305440.0 305775.0 305887.0 22757.8 22783.4 22976.2 22986.7 23049.5 40147.6 40452.8 40464.0 41650.4 41870.4 35458.8 35581.8 35803.6 36184.5 36560.5 34866.0 35108.1 35316.5 35412.3 35755.0 34304.0 34538.7 34614.7 35624.5 35662.3 29257.9 31591.5 31720.8 31839.4 31842.8 24227.4 24840.4 25827.6 26106.3 27019.3 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#2] jquery.html Cycles:180 Average:22669.22 Median:4559.33 stddev:59042.66 (1295.0%) stddev-sans-first:59184.52 09:35:30 INFO - PROCESS | 25334 | Values: 356.7 358.1 370.1 370.3 389.3 15242.3 15600.0 16802.8 16882.0 16941.2 14558.2 14695.6 14979.6 15061.2 15098.2 4919.1 5094.2 5181.5 5215.0 5225.9 5149.9 5252.6 5258.2 5261.3 5276.7 5022.5 5110.7 5114.5 5121.4 5121.5 5103.3 5117.6 5179.4 5180.4 5204.2 4392.5 4538.7 4547.4 4551.3 4567.4 19601.0 19609.1 19981.0 20035.6 20063.4 1831.5 1956.9 2072.4 2417.5 2454.2 13067.0 13142.3 13163.1 13203.3 13583.6 1655.6 1661.8 1708.6 1721.7 1732.9 42754.0 65105.7 66466.7 69400.0 69461.0 9315.2 9345.9 9361.4 9412.7 9431.8 12842.6 12914.9 13020.2 13045.7 13056.7 6584.6 6589.7 6746.7 6772.4 6920.2 6123.8 6193.5 6278.7 6397.2 6403.7 5885.6 5983.8 6004.7 6082.1 6100.7 1747.2 1792.5 1795.7 1796.1 1807.5 782.3 848.3 876.4 906.8 924.6 15764.2 16389.8 16630.3 16996.0 17512.1 369.6 383.3 384.1 823.6 888.8 5060.6 5455.6 5557.3 5588.4 5683.2 351766.0 353684.0 357674.0 358999.0 360165.0 74894.0 76058.0 76118.0 77174.6 77809.0 404.3 413.3 414.1 414.2 415.0 9788.7 9911.1 9981.5 10037.3 10344.7 36185.0 36288.8 37205.0 37544.2 37761.0 46219.0 47012.5 47333.8 51176.0 52905.5 7241.0 7426.9 7473.9 7537.4 7860.6 10888.8 11913.2 11934.6 11994.6 12243.8 4785.0 6803.8 10154.4 10420.7 10577.2 9569.5 9736.7 9795.7 9883.2 10040.4 4840.0 5068.5 9831.0 10325.3 10667.4 7384.6 7461.2 7557.4 7647.1 7776.1 10168.5 10428.3 10477.3 10647.7 10960.8 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#3] mootools.html Cycles:180 Average:4977.89 Median:5258.51 stddev:2763.80 (52.6%) stddev-sans-first:2758.29 09:35:30 INFO - PROCESS | 25334 | Values: 1374.5 1416.0 1506.6 1656.3 1717.1 6584.2 6818.0 7071.2 7689.2 7724.8 7289.1 7617.3 7627.0 7786.2 7800.4 2072.9 2101.0 2110.2 2111.8 2112.3 2071.2 2082.8 2093.7 2141.8 2142.6 2076.1 2115.7 2115.9 2117.3 2118.6 2015.0 2020.9 2031.9 2032.0 2039.6 2026.9 2032.7 2061.1 2066.8 2067.2 7605.2 7676.3 7677.0 7738.1 7807.2 4224.6 4337.3 4338.4 4340.5 4350.5 2893.9 2912.6 2944.6 3023.6 3093.1 870.3 920.1 923.9 947.4 1696.8 9881.6 10302.6 10317.4 10355.3 10355.9 3661.8 3854.8 3918.1 3943.8 4012.4 7920.6 7965.6 7975.6 7983.1 7984.3 4305.6 4323.1 4327.1 4327.2 4332.0 3443.0 3547.0 3835.6 4048.7 4066.7 3516.7 3663.4 3673.7 3692.9 3733.2 1146.0 1154.7 1179.3 1183.2 1200.6 799.4 834.3 853.3 862.6 882.7 4930.9 5046.1 5172.8 5183.9 5352.9 791.7 850.2 854.0 874.9 891.1 3458.2 3528.2 3528.3 3537.7 3661.0 9010.5 9342.0 9477.9 9527.2 9607.2 9442.7 9444.9 9466.8 9483.1 9523.5 7183.2 7244.3 7286.6 7323.7 7388.5 4987.6 5219.8 5297.2 5334.6 5359.1 8429.5 8519.0 8538.7 8549.1 8614.2 8434.2 8564.6 8649.6 8717.3 8791.8 5938.6 6023.3 6664.2 6772.6 6818.0 7262.3 7430.4 7476.4 7496.8 7532.1 6697.0 6707.4 6797.6 6976.8 6993.9 6649.2 6737.1 6757.9 6893.5 6937.9 5957.5 6049.6 6060.0 6064.0 6073.1 4199.3 4325.7 4400.9 4406.7 4423.4 4473.2 4485.6 4527.9 4617.5 4631.3 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#4] prototype.html Cycles:180 Average:4355.92 Median:5035.93 stddev:1300.64 (25.8%) stddev-sans-first:1268.00 09:35:30 INFO - PROCESS | 25334 | Values: 291.0 292.6 296.7 297.0 300.0 5107.5 5137.3 5140.5 5148.7 5152.4 4981.4 4988.5 5011.9 5013.9 5041.8 3690.3 3724.4 3808.9 3833.6 3866.0 3849.8 3853.6 3860.9 3865.3 3880.5 3838.2 3847.9 3848.5 3853.2 3859.5 3727.0 3805.9 3812.8 3861.6 3875.4 3326.0 3344.9 3347.5 3347.8 3354.0 4810.0 4812.4 4831.4 4846.8 4860.2 4384.0 4405.8 4423.6 4433.4 4440.5 5060.3 5194.0 5217.0 5217.2 5235.0 3651.8 3669.2 3676.8 3678.8 3680.6 5477.6 5483.6 5506.2 5507.8 5507.9 3503.4 3716.0 3724.1 3738.6 3747.3 3766.1 3767.0 3774.8 3776.0 3786.7 4388.6 4392.1 4392.9 4397.9 4408.8 5145.3 5281.9 5312.8 5337.5 5354.5 1308.2 1309.7 1311.8 1314.4 1321.4 777.0 814.8 817.5 822.5 825.9 4458.4 4610.6 4631.8 4669.8 4670.9 5541.8 5549.9 5562.6 5575.7 5578.0 4539.7 4642.0 4647.8 4652.2 4714.9 2840.6 2883.2 2898.2 2905.4 2935.5 5112.4 5123.8 5132.6 5148.4 5153.8 5291.5 5577.4 5581.6 5612.9 5624.3 5113.4 5118.2 5118.6 5137.3 5159.2 5484.3 5531.3 5533.3 5542.7 5554.8 5172.0 5389.0 5397.8 5420.4 5424.2 5100.6 5111.7 5112.3 5119.4 5142.8 3748.7 3749.1 3774.1 3793.6 3806.5 5393.7 5431.9 5445.2 5489.4 5541.8 5263.4 5271.6 5278.4 5280.7 5305.5 5303.0 5304.9 5311.6 5373.5 5383.8 4817.8 5127.4 5136.7 5156.0 5165.1 5030.1 5160.5 5166.7 5283.3 5316.8 5175.2 5182.4 5211.8 5242.6 5260.9 09:35:30 INFO - PROCESS | 25334 | 09:35:30 INFO - PROCESS | 25334 | [#5] yui.html Cycles:180 Average:16366.90 Median:26706.51 stddev:22021.26 (82.5%) stddev-sans-first:22051.31 09:35:30 INFO - PROCESS | 25334 | Values: 625.9 639.7 642.4 666.0 724.5 12979.6 13636.1 13943.9 13961.7 14400.9 14164.6 14212.5 14237.5 14251.4 14281.2 602.7 634.8 746.1 764.1 784.1 795.2 814.8 814.9 815.5 816.3 852.2 854.6 855.2 855.8 857.3 846.5 847.7 847.9 848.8 850.5 619.7 620.3 620.5 621.4 622.6 14268.6 14401.5 14447.6 14459.5 14480.0 12367.2 12661.1 12766.0 12929.8 13251.9 10507.2 10550.5 10786.9 10919.7 11359.7 3284.2 3293.6 3342.6 3355.1 3381.2 60077.1 60135.4 60438.4 61095.7 61469.0 9670.0 9821.2 9856.3 9914.9 9982.1 18267.7 18450.8 18454.4 18479.9 18810.9 6135.1 6335.8 6617.5 6678.1 6847.0 3171.3 3271.8 3550.8 3598.5 3659.2 2912.9 2997.2 3017.4 3021.1 3029.0 483.9 485.9 495.9 501.3 508.0 592.9 595.7 611.3 613.6 643.4 7321.5 7329.3 7618.0 7652.6 7827.3 487.3 514.3 517.0 585.7 619.5 3407.7 3667.0 3670.3 3680.4 3852.2 68619.0 82422.6 86448.6 86508.6 86640.6 64245.7 75500.6 75557.6 77720.2 78779.0 58927.4 65497.0 66221.0 67861.0 68006.7 7651.5 8106.6 8238.4 8279.7 8294.7 38255.8 38696.2 40660.8 40920.4 42219.2 47849.8 48393.8 51516.0 52896.0 55987.4 10044.0 10619.0 10875.5 11121.0 11663.8 13010.5 13072.3 13264.2 13317.7 13978.2 11870.3 11992.3 12079.1 12233.3 12247.8 11810.2 11976.5 12300.3 12349.3 12683.9 11047.5 11302.4 11591.1 11864.1 11896.9 9258.6 9515.2 9598.6 9644.0 9707.0 9163.7 9213.9 9720.8 9781.6 9866.6 09:35:30 INFO - PROCESS | 25334 | -------- Summary: end -------- 09:35:30 INFO - PROCESS | 25334 | 09:35:31 INFO - TEST-INFO | 25334: exit 0 09:35:31 INFO - TEST-OK | dromaeo_css | took 1119806ms 09:35:31 INFO - TEST-START | kraken 09:35:31 INFO - operating with platform_type : linux_ 09:35:31 INFO - Initialising browser for kraken test... 09:35:31 INFO - TEST-INFO | started process 25692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMhsUy/profile http://localhost:54772/getInfo.html) 09:35:36 INFO - PROCESS | 25692 | __metrics Screen width/height:1600/1200 09:35:36 INFO - PROCESS | 25692 | colorDepth:24 09:35:36 INFO - PROCESS | 25692 | Browser inner width/height: 1024/697 09:35:36 INFO - PROCESS | 25692 | __metrics 09:35:36 ERROR - PROCESS | 25692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 09:35:37 INFO - TEST-INFO | 25692: exit 0 09:35:37 INFO - Browser initialized. 09:35:37 INFO - Running cycle 1/1 for kraken test... 09:35:37 INFO - TEST-INFO | started process 25814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJMhsUy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:50 INFO - PROCESS | 25814 | RSS: Main: 183250944 09:35:50 INFO - PROCESS | 25814 | 09:35:52 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54772/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:53 INFO - PROCESS | 25814 | RSS: Main: 196771840 09:35:53 INFO - PROCESS | 25814 | 09:35:56 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54772/tests/kraken/driver.html?testName=audio-dft) 09:35:57 INFO - PROCESS | 25814 | RSS: Main: 194789376 09:35:57 INFO - PROCESS | 25814 | 09:36:00 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54772/tests/kraken/driver.html?testName=audio-fft) 09:36:00 INFO - PROCESS | 25814 | RSS: Main: 191385600 09:36:00 INFO - PROCESS | 25814 | 09:36:02 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54772/tests/kraken/driver.html?testName=audio-oscillator) 09:36:03 INFO - PROCESS | 25814 | RSS: Main: 192262144 09:36:03 INFO - PROCESS | 25814 | 09:36:05 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:06 INFO - PROCESS | 25814 | RSS: Main: 192241664 09:36:06 INFO - PROCESS | 25814 | 09:36:09 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54772/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:10 INFO - PROCESS | 25814 | RSS: Main: 192135168 09:36:10 INFO - PROCESS | 25814 | 09:36:13 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54772/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:14 INFO - PROCESS | 25814 | RSS: Main: 190701568 09:36:14 INFO - PROCESS | 25814 | 09:36:17 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54772/tests/kraken/driver.html?testName=json-parse-financial) 09:36:17 INFO - PROCESS | 25814 | RSS: Main: 192430080 09:36:17 INFO - PROCESS | 25814 | 09:36:19 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:20 INFO - PROCESS | 25814 | RSS: Main: 192671744 09:36:20 INFO - PROCESS | 25814 | 09:36:22 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:22 INFO - PROCESS | 25814 | RSS: Main: 192937984 09:36:22 INFO - PROCESS | 25814 | 09:36:24 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:25 INFO - PROCESS | 25814 | RSS: Main: 192843776 09:36:25 INFO - PROCESS | 25814 | 09:36:28 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:29 INFO - PROCESS | 25814 | RSS: Main: 193323008 09:36:29 INFO - PROCESS | 25814 | 09:36:32 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:32 INFO - PROCESS | 25814 | RSS: Main: 193032192 09:36:32 INFO - PROCESS | 25814 | 09:36:34 INFO - PROCESS | 25814 | Cycle 1(1): loaded http://localhost:54772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54772/tests/kraken/driver.html?testName=ai-astar) 09:36:35 INFO - PROCESS | 25814 | RSS: Main: 194220032 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | __start_tp_report 09:36:35 INFO - PROCESS | 25814 | _x_x_mozilla_page_load 09:36:35 INFO - PROCESS | 25814 | _x_x_mozilla_page_load_details 09:36:35 INFO - PROCESS | 25814 | |i|pagename|runs| 09:36:35 INFO - PROCESS | 25814 | |0;ai-astar;115;117;116;115;118;116;115;118;116;118 09:36:35 INFO - PROCESS | 25814 | |1;audio-beat-detection;152;132;130;165;128;130;132;129;164;130 09:36:35 INFO - PROCESS | 25814 | |2;audio-dft;165;167;165;169;163;163;163;165;163;162 09:36:35 INFO - PROCESS | 25814 | |3;audio-fft;75;86;78;111;77;76;77;76;102;78 09:36:35 INFO - PROCESS | 25814 | |4;audio-oscillator;84;84;110;84;84;84;101;84;84;109 09:36:35 INFO - PROCESS | 25814 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;118;118;118 09:36:35 INFO - PROCESS | 25814 | |6;imaging-darkroom;149;147;147;147;148;148;149;147;147;147 09:36:35 INFO - PROCESS | 25814 | |7;imaging-desaturate;85;86;86;85;84;85;85;85;85;85 09:36:35 INFO - PROCESS | 25814 | |8;json-parse-financial;64;65;65;66;65;65;66;66;64;65 09:36:35 INFO - PROCESS | 25814 | |9;json-stringify-tinderbox;68;68;68;69;68;67;68;68;69;68 09:36:35 INFO - PROCESS | 25814 | |10;stanford-crypto-aes;86;84;91;85;93;92;83;87;84;85 09:36:35 INFO - PROCESS | 25814 | |11;stanford-crypto-ccm;154;153;145;163;143;144;146;158;189;164 09:36:35 INFO - PROCESS | 25814 | |12;stanford-crypto-pbkdf2;182;183;193;176;191;184;181;178;178;177 09:36:35 INFO - PROCESS | 25814 | |13;stanford-crypto-sha256-iterative;73;71;74;70;71;72;69;70;73;69 09:36:35 INFO - PROCESS | 25814 | __end_tp_report 09:36:35 INFO - PROCESS | 25814 | __start_cc_report 09:36:35 INFO - PROCESS | 25814 | _x_x_mozilla_cycle_collect,864 09:36:35 INFO - PROCESS | 25814 | __end_cc_report 09:36:35 INFO - PROCESS | 25814 | __startTimestamp1476981395004__endTimestamp 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | ------- Summary: start ------- 09:36:35 INFO - PROCESS | 25814 | Number of tests: 14 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.50 stddev:1.26 (1.1%) stddev-sans-first:1.24 09:36:35 INFO - PROCESS | 25814 | Values: 115.0 117.0 116.0 115.0 118.0 116.0 115.0 118.0 116.0 118.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:132.00 stddev:15.02 (11.4%) stddev-sans-first:15.21 09:36:35 INFO - PROCESS | 25814 | Values: 152.0 132.0 130.0 165.0 128.0 130.0 132.0 129.0 164.0 130.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 09:36:35 INFO - PROCESS | 25814 | Values: 165.0 167.0 165.0 169.0 163.0 163.0 163.0 165.0 163.0 162.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:12.62 (16.4%) stddev-sans-first:13.00 09:36:35 INFO - PROCESS | 25814 | Values: 75.0 86.0 78.0 111.0 77.0 76.0 77.0 76.0 102.0 78.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:11.19 (13.3%) stddev-sans-first:11.60 09:36:35 INFO - PROCESS | 25814 | Values: 84.0 84.0 110.0 84.0 84.0 84.0 101.0 84.0 84.0 109.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:36:35 INFO - PROCESS | 25814 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 09:36:35 INFO - PROCESS | 25814 | Values: 149.0 147.0 147.0 147.0 148.0 148.0 149.0 147.0 147.0 147.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 09:36:35 INFO - PROCESS | 25814 | Values: 85.0 86.0 86.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 09:36:35 INFO - PROCESS | 25814 | Values: 64.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 64.0 65.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 09:36:35 INFO - PROCESS | 25814 | Values: 68.0 68.0 68.0 69.0 68.0 67.0 68.0 68.0 69.0 68.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:3.65 (4.2%) stddev-sans-first:3.86 09:36:35 INFO - PROCESS | 25814 | Values: 86.0 84.0 91.0 85.0 93.0 92.0 83.0 87.0 84.0 85.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:156.00 stddev:13.96 (8.9%) stddev-sans-first:14.79 09:36:35 INFO - PROCESS | 25814 | Values: 154.0 153.0 145.0 163.0 143.0 144.0 146.0 158.0 189.0 164.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:182.50 stddev:5.77 (3.2%) stddev-sans-first:6.12 09:36:35 INFO - PROCESS | 25814 | Values: 182.0 183.0 193.0 176.0 191.0 184.0 181.0 178.0 178.0 177.0 09:36:35 INFO - PROCESS | 25814 | 09:36:35 INFO - PROCESS | 25814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.75 (2.4%) stddev-sans-first:1.73 09:36:35 INFO - PROCESS | 25814 | Values: 73.0 71.0 74.0 70.0 71.0 72.0 69.0 70.0 73.0 69.0 09:36:35 INFO - PROCESS | 25814 | -------- Summary: end -------- 09:36:35 INFO - PROCESS | 25814 | 09:36:36 INFO - TEST-INFO | 25814: exit 0 09:36:36 INFO - TEST-OK | kraken | took 64729ms 09:36:36 INFO - SUITE-END | took 1184s 09:36:36 INFO - Completed test suite (00:19:44) 09:36:36 INFO - javascript benchmark 09:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6280.865168093375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.416028473736, 2678.0, 2685.1810197889636, 2694.312950197699, 2699.8245114067577, 4753.405824271966, 4796.7601619919, 4802.087603355369, 4838.201696720042, 4851.393575803025, 4747.572718455338, 4813.90372192556, 4822.035592881429, 4827.78274977626, 4921.680090794105, 4347.456567929009, 4422.535633758457, 4429.6899217054815, 4468.865934021985, 4533.433320834895, 4117.197146556423, 4580.038191979688, 4581.40441742573, 4605.907881842361, 4617.261238201889, 4318.1363727254675, 4499.212637788374, 4515.390422292981, 4538.0, 4616.238320677085, 4338.913221735579, 4342.826286948518, 4365.716228445172, 4389.670774691911, 4408.272635015219, 4324.805383757707, 4330.220560299145, 4365.2142614329405, 4392.758398288093, 4394.121175764828, 4745.905081898342, 4780.521947805227, 4791.137595232856, 4791.161546729309, 4836.975815120902, 5105.463926287724, 5170.6122040847085, 5177.663451875616, 5185.351831021122, 5209.687418754849, 5176.327077479941, 5176.430592634807, 5193.324867767166, 5193.428722840485, 5229.712365819878, 4781.952180478151, 4793.784279707422, 4823.1800593899125, 4823.445303790038, 4824.855254342376, 5171.948280517222, 5173.1464308388695, 5198.714070726146, 5214.921776173284, 5289.545375021899, 5004.524570165829, 5012.298278241049, 5013.172826483589, 5013.896942672606, 5056.82301119459, 5036.269740887551, 5051.166557518042, 5105.2086926526445, 5115.437301896788, 5116.437191908887, 5068.113080210948, 5124.461931497139, 5142.51146141116, 5178.6116041297055, 5221.242919776611, 5121.615878809104, 5127.230915362651, 5127.846164615067, 5133.0, 5136.794528218829, 4384.6711496637245, 4408.669349798778, 4409.867703968886, 4462.419885414875, 4462.620677242406, 3770.3967365221984, 3796.981015094907, 3802.372608519563, 3833.4441505981476, 3878.398848178537, 4430.180416622935, 4439.866803995886, 4447.355133505624, 4469.620082292977, 4496.595306422438, 5172.120739474299, 5191.922121168185, 5217.087009773274, 5228.058949389147, 5293.258943747878, 4354.8911277217685, 4358.607725304738, 4401.273789824643, 4432.423784907941, 4433.977830110829, 4686.461056978491, 4695.24876019842, 4703.976480117578, 4704.717716936994, 4714.929276060861, 4844.903101937942, 4844.927326090182, 4848.321235027099, 4848.393950756155, 4856.028794241095, 5213.165893457029, 5263.36839579253, 5264.763085661231, 5318.7340632967425, 5333.813316533902, 4888.853334399973, 4894.828680996148, 4899.706017638953, 4908.435529914105, 4958.752062396794, 5023.799048038184, 5070.087384270867, 5164.896702066013, 5174.0, 5178.275041494118, 5130.435652078343, 5162.845114646567, 5182.844514664566, 5205.6616319939085, 5216.6348355616265, 4927.778249978688, 4997.175466048061, 5005.624578156726, 5048.848534543969, 5062.265971434195, 4990.3762029746285, 5007.349044624321, 5016.4231113420965, 5023.397192336943, 5042.571381432619, 4819.7108173509705, 4894.119058569349, 4921.212605983025, 4925.753712314442, 4928.753562321941, 5145.639805213599, 5147.536721695065, 5160.045391602565, 5189.6107791915, 5191.195364718475, 5007.349044624176, 5038.746220940299, 5041.117804384145, 5056.191009438472, 5063.594912406925], "value": 4740.770996127218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.9256704061432, 546.469924173552, 554.2600628161405, 564.6273459516717, 567.8835838653076, 38237.23525529491, 40406.59593404065, 40425.59574404255, 43713.34429983553, 43755.34366984498, 40116.799416002956, 40613.0, 40659.39010914831, 40686.0, 40747.38878916819, 7486.02681651386, 7495.812604684899, 7547.50941188821, 7595.772126836204, 7596.810079747996, 7652.540847549137, 7717.6912923483, 7725.536467811921, 7735.806604834868, 7757.49576277543, 7783.844323113534, 7810.9609451952665, 7813.9609301953415, 7822.960885195566, 7827.569483678395, 7728.227177282283, 7742.61286935651, 7752.069751629812, 7766.57283849388, 7773.144954055049, 7628.351590114847, 7672.117706463772, 7676.731314403969, 7677.30904218623, 7683.270089341504, 38443.61556384428, 38655.22689546221, 38723.0, 38736.418953715714, 38748.0, 2777.125205560242, 3121.5473756305437, 3218.0185043561705, 3516.82415879205, 3531.9117022074397, 27770.861145694143, 28022.299442513897, 28208.294792630142, 28309.292267693265, 28365.574516382272, 3406.0823607571538, 3503.807290599016, 3507.0530956641564, 3541.628129046439, 3548.1484443733316, 238301.0, 238714.0, 238771.0, 238837.0, 239258.0, 50002.0, 50120.24819627708, 50355.24467132996, 50472.0, 50555.49444505582, 53523.19715204275, 54073.0, 54116.72941635267, 54207.0, 54310.45689543054, 12285.815712764315, 12395.256284622952, 12457.875421245672, 12464.127511074137, 12529.43617537213, 8995.100489950952, 9037.909620903707, 9084.137006984325, 9089.590968406437, 9109.316801239933, 13299.468021279234, 15417.845821541865, 15424.922875385551, 15570.221488925508, 15594.454194103151, 2913.6503619565788, 5425.48758953201, 5606.719664016783, 5860.267466566679, 5917.970410148007, 751.5227830327672, 830.2693629605908, 837.351052933981, 918.3342076994126, 928.6192661009089, 25580.488390232462, 26394.472110557683, 27051.421777469455, 27526.17421477359, 27595.172144835688, 903.4714691905309, 965.8164948659733, 980.774421882971, 982.150439869522, 985.9507024648739, 13502.864971350356, 14353.497627582985, 14353.856461435253, 14431.0, 14612.853871461362, 351877.0, 356467.0, 359891.0, 360286.0, 360816.0, 50399.24401133986, 50914.0, 50964.74517627388, 51095.0, 51214.74392628013, 1119.8096323625002, 1147.5008371358485, 1152.7924973504682, 1161.4599211366585, 1161.4831400027076, 25319.873400632878, 26142.73857261403, 27278.454430911668, 27639.447211056067, 27734.0, 41958.0, 42293.0, 42354.78822605991, 42389.0, 42496.78751606346, 302133.0, 304774.0, 305440.0, 305775.0, 305887.0, 22757.772422275564, 22783.430414239778, 22976.19583314576, 22986.655200171677, 23049.539009220058, 40147.59852401556, 40452.79773601113, 40464.0, 41650.37524437075, 41870.371944421466, 35458.822705886305, 35581.82209088938, 35803.641963580034, 36184.45723314205, 36560.45159322665, 34866.0, 35108.12229694278, 35316.47025294674, 35412.29175416426, 35755.0, 34304.0, 34538.654613453546, 34614.65385346215, 35624.46563301604, 35662.28675426425, 29257.85371073131, 31591.526127107652, 31720.841395792875, 31839.36321273608, 31842.84078579592, 24227.39431514226, 24840.37899052538, 25827.612585811603, 26106.347341316618, 27019.324516887234], "value": 16812.81406005181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6522640425587, 358.1404628890662, 370.1191165027235, 370.32231017238456, 389.2914894891299, 15242.314095865684, 15600.0, 16802.83197168028, 16882.0, 16941.152942352895, 14558.199299038548, 14695.559133226021, 14979.625509362271, 15061.17163556004, 15098.16960067196, 4919.139150648631, 5094.1594636884865, 5181.455947125554, 5215.0, 5225.869353266161, 5149.897002059956, 5252.579793616502, 5258.158694608864, 5261.263423120766, 5276.683398996072, 5022.497750224985, 5110.744462776865, 5114.462981386938, 5121.385433747955, 5121.462246464123, 5103.311053007834, 5117.592662017956, 5179.378474583036, 5180.430152683201, 5204.245384419257, 4392.450943632046, 4538.7276763393975, 4547.386102876136, 4551.271796512575, 4567.378580603871, 19601.0, 19609.117589708498, 19981.0, 20035.599288014302, 20063.39809805708, 1831.5146486181172, 1956.8923709195988, 2072.4093633314433, 2417.4560723836994, 2454.202384225116, 13067.0, 13142.277174755385, 13163.144395614254, 13203.2738199399, 13583.592492225249, 1655.6026553627044, 1661.7590449384772, 1708.6326439815375, 1721.6900957827586, 1732.904690242049, 42754.0, 65105.743189421715, 66466.66766666184, 69400.0, 69460.95808562926, 9315.161635452841, 9345.859812102688, 9361.391509551993, 9412.670556530626, 9431.821022372204, 12842.550510732266, 12914.870851291555, 13020.218786872818, 13045.739085218242, 13056.738865222642, 6584.604923704593, 6589.670516474253, 6746.662666866637, 6772.424343930821, 6920.169579650475, 6123.785667501706, 6193.535484838655, 6278.6860656966965, 6397.168368112209, 6403.679816009181, 5885.646861188342, 5983.820485385445, 6004.729787159501, 6082.118092876596, 6100.69496525172, 1747.2254199869299, 1792.453301742981, 1795.6588248232795, 1796.1499655355005, 1807.493901707524, 782.2685788787502, 848.295914391054, 876.3602570123718, 906.845836207833, 924.6209054287845, 15764.211789410483, 16389.83610163907, 16630.251638676287, 16996.0, 17512.124393780516, 369.64329422107795, 383.31769450377817, 384.11269966377756, 823.56762699582, 888.8089060851947, 5060.645754797129, 5455.5908306877145, 5557.3331200256225, 5588.413216612197, 5683.204351390808, 351766.0, 353684.0, 357674.0, 358999.0, 360165.0, 74894.0, 76058.0, 76118.0, 77174.61412692901, 77809.0, 404.3045960947166, 413.3242149086266, 414.08693830104545, 414.22539850479194, 414.9585041495826, 9788.706338809847, 9911.10800028001, 9981.452874804418, 10037.34757240777, 10344.741381465523, 36185.0, 36288.81855590705, 37205.0, 37544.249115018094, 37761.0, 46219.0, 47012.52987470081, 47333.7633311845, 51176.0, 52905.47094529006, 7241.0, 7426.888596670946, 7473.850522989401, 7537.359324457482, 7860.646270917937, 10888.836667450152, 11913.22564033335, 11934.582289619822, 11994.580189693319, 12243.755124897274, 4785.042991401664, 6803.761868334783, 10154.44150571696, 10420.739481513023, 10577.153827693919, 9569.521523923915, 9736.659216927657, 9795.706128815862, 9883.209343252667, 10040.397576145455, 4839.95160048395, 5068.518490743373, 9830.950845245728, 10325.277230594087, 10667.413292269, 7384.593847338448, 7461.179270280156, 7557.395408367208, 7647.082350118021, 7776.144624091232, 10168.491575421347, 10428.27002109845, 10477.266591338534, 10647.680569582924, 10960.835587466354], "value": 7558.497253309777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.491438167878, 1416.0370947755528, 1506.6082818467196, 1656.2629629814721, 1717.0813614716121, 6584.176977877765, 6817.965910170455, 7071.222165561784, 7689.154193038768, 7724.845503089935, 7289.088863892013, 7617.276358745924, 7627.046619172604, 7786.182450842665, 7800.3759699224065, 2072.865263757855, 2100.9894950525227, 2110.155937624947, 2111.767705552388, 2112.2923820520145, 2071.1818831561523, 2082.760482544504, 2093.696414019966, 2141.753698324697, 2142.6036183306137, 2076.0553947953645, 2115.7038014677955, 2115.9259425920095, 2117.2907076129513, 2118.5762847430574, 2014.979850201494, 2020.8888511131881, 2031.8520036179584, 2032.0246281784825, 2039.6328660841043, 2026.929057482981, 2032.6849338352579, 2061.1034200122995, 2066.8243199328076, 2067.235123004498, 7605.201453847377, 7676.270754278335, 7677.0, 7738.110117336522, 7807.180246074137, 4224.577542245782, 4337.306031035051, 4338.414314067592, 4340.47914250292, 4350.521442641307, 2893.85530723463, 2912.563115532666, 2944.6319210098736, 3023.5918151049545, 3093.0875391759487, 870.3211495033884, 920.1396694090979, 923.8568021956607, 947.4220725357526, 1696.8048674402355, 9881.604735810559, 10302.587896484132, 10317.380957142595, 10355.326903751233, 10355.89644103557, 3661.7802931823644, 3854.768713877176, 3918.1380096378753, 3943.8225279862477, 4012.398140278923, 7920.564368959647, 7965.641546130438, 7975.641096150687, 7983.081945576217, 7984.321332686671, 4305.590968857953, 4323.092150648336, 4327.091310824699, 4327.17783621111, 4331.97834010828, 3442.982785086109, 3547.0068380853404, 3835.5972622874197, 4048.716589838742, 4066.694997875112, 3516.6659167379057, 3663.413853783435, 3673.7061035117663, 3692.9076773080888, 3733.178700685845, 1145.9828102578467, 1154.653603918821, 1179.3101035893926, 1183.207251141737, 1200.6158029430499, 799.4124318625805, 834.3200291762315, 853.2619284319144, 862.6247582301719, 882.6601758323092, 4930.852074437773, 5046.142155833517, 5172.818951336685, 5183.922241166386, 5352.918960822157, 791.6754130806341, 850.1923172985688, 853.9573021348908, 874.8731433942042, 891.0999890110905, 3458.239187378773, 3528.188516641187, 3528.2590655962535, 3537.7346698997676, 3660.9816950915074, 9010.504422256708, 9341.953290233505, 9477.905220947703, 9527.237820974306, 9607.231421486264, 9442.716718498456, 9444.90555094454, 9466.810663786686, 9483.051694830461, 9523.523823808782, 7183.245759195313, 7244.275572442713, 7286.562806231643, 7323.670434830446, 7388.519746216479, 4987.60099192071, 5219.791208351623, 5297.231901374356, 5334.626576139633, 5359.088954877758, 8429.536375499407, 8518.957405212934, 8538.701145460127, 8549.102344254012, 8614.18165274298, 8434.198751118634, 8564.57177141128, 8649.61076751535, 8717.302615790595, 8791.780205494659, 5938.584299099021, 6023.30731965812, 6664.233613134552, 6772.55978361405, 6817.965910170417, 7262.31008054234, 7430.368418684472, 7476.401887849068, 7496.812579685551, 7532.096148462219, 6697.0, 6707.3628005339415, 6797.626130562867, 6976.825579360557, 6993.860122797617, 6649.168853893263, 6737.095866393708, 6757.93242067573, 6893.517453778188, 6937.89593156093, 5957.463828255478, 6049.606775559574, 6059.969700151471, 6063.969680151571, 6073.149759033827, 4199.265128602544, 4325.697201195886, 4400.867973960786, 4406.669499787465, 4423.358613001033, 4473.150101480708, 4485.596296333215, 4527.909441811211, 4617.53824617549, 4631.282151266559], "value": 4039.4567850534254, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.9839958802266, 292.6254394375199, 296.6588423313191, 296.9502807575222, 299.9850007499625, 5107.463716309785, 5137.255098010795, 5140.5373516383515, 5148.716820574867, 5152.40747314059, 4981.427135879375, 4988.4762099979525, 5011.899762004758, 5013.899722005567, 5041.798328066882, 3690.317291301118, 3724.404095344745, 3808.885733427988, 3833.5624140947143, 3866.0, 3849.788261645608, 3853.556840963283, 3860.8841734748003, 3865.323568375523, 3880.5343358796986, 3838.2131663009154, 3847.941816000608, 3848.461215429842, 3853.2293541291715, 3859.536855577335, 3726.9627303727157, 3805.8744580321213, 3812.8474861005525, 3861.575226725058, 3875.379939209713, 3325.9501107483406, 3344.8996530104137, 3347.548081009057, 3347.782394144373, 3353.983230083834, 4810.0, 4812.37439132914, 4831.4202295724735, 4846.830360937351, 4860.198067318888, 4383.956160438387, 4405.801738921757, 4423.5576442355505, 4433.357163211316, 4440.4671439427475, 5060.292743382272, 5193.9740301298625, 5216.956858434705, 5217.16525355945, 5235.0, 3651.8174091295327, 3669.1560940983454, 3676.7793932363875, 3678.797666128362, 3680.576733675608, 5477.589180811416, 5483.616146869721, 5506.201600767907, 5507.752151153208, 5507.917381239245, 3503.4394496880377, 3715.981420092882, 3724.1434470072036, 3738.5700644425697, 3747.269282489888, 3766.077311058808, 3767.0411386079086, 3774.8490060397276, 3775.962240377616, 3786.73492855503, 4388.648908087345, 4392.07766369066, 4392.912141757147, 4397.934030989538, 4408.7875834145225, 5145.331106956071, 5281.9207711884355, 5312.76092575835, 5337.5463085637375, 5354.491323324278, 1308.2281453942219, 1309.7315050414643, 1311.8229039079793, 1314.3888092037248, 1321.4185758266524, 776.9844603107906, 814.7981726952697, 817.5380909785952, 822.5147163173756, 825.8885050518223, 4458.35353873693, 4610.561996610317, 4631.791569379386, 4669.789859456333, 4670.906581868411, 5541.810984661036, 5549.944500555023, 5562.638428502134, 5575.69333686643, 5578.0, 4539.7301349325335, 4642.0, 4647.790849411785, 4652.232381657056, 4714.929276060861, 2840.5881147233536, 2883.2071180425132, 2898.1595337351932, 2905.389868127717, 2935.500964835983, 5112.389597276846, 5123.795048198105, 5132.615053870974, 5148.382194136728, 5153.845384638467, 5291.497307755757, 5577.44225577439, 5581.581381396411, 5612.943870561324, 5624.29696287964, 5113.41195762492, 5118.232265160255, 5118.641695081308, 5137.255098010693, 5159.200323949719, 5484.2578710644675, 5531.336239651107, 5533.253010843485, 5542.722863856871, 5554.750036248298, 5171.974140129426, 5389.0, 5397.757100930389, 5420.376656684532, 5424.159255315432, 5100.566451851634, 5111.718855462986, 5112.284280200849, 5119.385673719177, 5142.794288228429, 3748.6626203641804, 3749.118957045038, 3774.1130834254477, 3793.639604237593, 3806.5051543299196, 5393.7033463159905, 5431.918521222264, 5445.156000819879, 5489.423610520837, 5541.750621221974, 5263.421023687315, 5271.551918087006, 5278.36659600835, 5280.656757310762, 5305.522502974596, 5303.0, 5304.885973945515, 5311.601629877852, 5373.462653734751, 5383.81156659515, 4817.759112044454, 5127.4103478099005, 5136.666116702402, 5156.035279714104, 5165.133350990236, 5030.063425581251, 5160.48395160481, 5166.715830629351, 5283.339582552181, 5316.787328506816, 5175.249588809676, 5182.40402353719, 5211.843644690665, 5242.633015688865, 5260.921086183634], "value": 3932.5400001455055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.859181684121, 639.68015992004, 642.38331202046, 666.0375757031092, 724.4638967164296, 12979.61061168164, 13636.113652612574, 13943.930280348597, 13961.720765584681, 14400.855991440083, 14164.575062748108, 14212.502562410318, 14237.501687440941, 14251.4299428023, 14281.21453320067, 602.6775675013869, 634.8000379880345, 746.1233051164887, 764.1212605503673, 784.145281643009, 795.1730200591378, 814.8370325934807, 814.9185081491863, 815.5188438821094, 816.2816721285291, 852.21170417364, 854.581255184958, 855.1875718067829, 855.7946092937681, 857.3312816003527, 846.5090247656344, 847.7329641163014, 847.9236868681818, 848.7962888906679, 850.4599579267148, 619.6746707978348, 620.2680836612795, 620.5283984172016, 621.3972446726668, 622.6295354264206, 14268.643283917881, 14401.495947641783, 14447.638809029753, 14459.493917712934, 14480.0, 12367.196132251465, 12661.113722039461, 12766.0, 12929.806052909214, 13251.871268675288, 10507.159427245802, 10550.472476376228, 10786.892131078666, 10919.727006824813, 11359.659210223625, 3284.178955261185, 3293.6212335581235, 3342.598888133415, 3355.13789846635, 3381.1547113221695, 60077.098843517386, 60135.39864601342, 60438.39561604416, 61095.694521527104, 61469.0, 9669.951650241705, 9821.214302855755, 9856.260780441495, 9914.851277230848, 9982.051705088004, 18267.72598411025, 18450.815491845176, 18454.35409760652, 18479.907600461913, 18810.905945470186, 6135.07973803933, 6335.841603959938, 6617.4706023518, 6678.121306623431, 6846.965765171142, 3171.302313491028, 3271.787333823294, 3550.822458877046, 3598.478220658042, 3659.213269147146, 2912.8689208985224, 2997.2057404787747, 3017.4417732719517, 3021.1087729119963, 3029.0307101727676, 483.9346688197119, 485.85667228167773, 495.91569433196446, 501.25063030768507, 507.99492005080214, 592.926802487499, 595.7348979703991, 611.3305930006725, 613.6318209074609, 643.359856942336, 7321.450891183076, 7329.340359367682, 7618.0, 7652.617369131633, 7827.25641064098, 487.27396179692005, 514.2748724298721, 517.0202466326366, 585.7305639405836, 619.5322531488787, 3407.727381809449, 3666.9633303667156, 3670.302642497917, 3680.4479328100465, 3852.210296889131, 68619.0, 82422.58788706138, 86448.56775716081, 86508.56745716358, 86640.56679716561, 64245.678771605846, 75500.62249688826, 75557.62221188859, 77720.2227977713, 78779.0, 58927.41072589305, 65497.0, 66221.0, 67861.0, 68006.65996669985, 7651.540907545343, 8106.635201416068, 8238.382121341043, 8279.742363599038, 8294.668213271643, 38255.808720956215, 38696.226075478895, 40660.79669601633, 40920.38619420651, 42219.15561688811, 47849.76075119602, 48393.75803120962, 51516.0, 52896.0, 55987.44012559822, 10044.0, 10619.0, 10875.51060202277, 11121.0, 11663.825042624538, 13010.479580816662, 13072.346382681018, 13264.204147751167, 13317.733645327233, 13978.231197284247, 11870.347130907883, 11992.280463172237, 12079.094067944763, 12233.327167005544, 12247.816282755588, 11810.173287869766, 11976.520939162336, 12300.261984280973, 12349.259044457362, 12683.936580317408, 11047.502862371373, 11302.43487825622, 11591.072714182677, 11864.11019173548, 11896.881031189578, 9258.583363748783, 9515.238780897373, 9598.568064436977, 9644.0, 9706.951465242912, 9163.679271225476, 9213.86179207299, 9720.805583888425, 9781.60873565078, 9866.55600497965], "value": 6414.313688580613, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 116.0, 115.0, 118.0, 116.0, 115.0, 118.0, 116.0, 118.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 130.0, 165.0, 128.0, 130.0, 132.0, 129.0, 164.0, 130.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 169.0, 163.0, 163.0, 163.0, 165.0, 163.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 86.0, 78.0, 111.0, 77.0, 76.0, 77.0, 76.0, 102.0, 78.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 84.0, 84.0, 84.0, 101.0, 84.0, 84.0, 109.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 91.0, 85.0, 93.0, 92.0, 83.0, 87.0, 84.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 145.0, 163.0, 143.0, 144.0, 146.0, 158.0, 189.0, 164.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 193.0, 176.0, 191.0, 184.0, 181.0, 178.0, 178.0, 177.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 74.0, 70.0, 71.0, 72.0, 69.0, 70.0, 73.0, 69.0], "value": 71.2, "unit": "score"}]}]} 09:36:36 INFO - Return code: 0 09:36:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:36 ERROR - # TBPL SUCCESS # 09:36:36 INFO - Running post-action listener: _resource_record_post_action 09:36:36 INFO - [mozharness: 2016-10-20 16:36:36.813154Z] Finished run-tests step (success) 09:36:36 INFO - Running post-run listener: _resource_record_post_run 09:36:36 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394342400; Read time: 12; Write time: 236020 09:36:36 INFO - TinderboxPrint: CPU usage
13.4% 09:36:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:36:36 INFO - TinderboxPrint: I/O write bytes / time
394,342,400 / 236,020 09:36:36 INFO - TinderboxPrint: CPU idle
8,301.3 (86.6%) 09:36:36 INFO - TinderboxPrint: CPU user
1,221.6 (12.7%) 09:36:36 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 101203968; Read time: 0; Write time: 68792 09:36:36 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293138432; Read time: 12; Write time: 167228 09:36:37 INFO - Running post-run listener: _upload_blobber_files 09:36:37 INFO - Blob upload gear active. 09:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:37 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 09:36:37 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:37 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:37 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:38 INFO - (blobuploader) - INFO - Done attempting. 09:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:42 INFO - (blobuploader) - INFO - Done attempting. 09:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:42 INFO - (blobuploader) - INFO - Done attempting. 09:36:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:42 INFO - Return code: 0 09:36:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c5232fd938bc95a1b560e848e291333718cf00e8c624b309b10fabd7f0a90dd7c5e17e214f0822f2d87f4e2094cfcc31f857ed3f56f9349dffe9420ba06ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f77dcc48b4b00618e0be340e6e4cbfe86f999c84c2ea36373a875c36cefbd4eb2d0262cfde5bc12036ac549bb1c3ee9ca90ec11ed13f6eb6504e3d0d32668f41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f55debd4f1423a4514e4698570fedc05f306265f2301dac8b2baa9fe86e66e9a111e6b07cd0414db9435935be4dc1ac2db6dc336573fd21b56fd807d89025c"} 09:36:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:42 INFO - Contents: 09:36:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c5232fd938bc95a1b560e848e291333718cf00e8c624b309b10fabd7f0a90dd7c5e17e214f0822f2d87f4e2094cfcc31f857ed3f56f9349dffe9420ba06ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f77dcc48b4b00618e0be340e6e4cbfe86f999c84c2ea36373a875c36cefbd4eb2d0262cfde5bc12036ac549bb1c3ee9ca90ec11ed13f6eb6504e3d0d32668f41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f55debd4f1423a4514e4698570fedc05f306265f2301dac8b2baa9fe86e66e9a111e6b07cd0414db9435935be4dc1ac2db6dc336573fd21b56fd807d89025c"} 09:36:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:42 INFO - Copying logs to upload dir... 09:36:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.713812 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-20 09:36:42.690434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:36:42.694182) ========= 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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c5232fd938bc95a1b560e848e291333718cf00e8c624b309b10fabd7f0a90dd7c5e17e214f0822f2d87f4e2094cfcc31f857ed3f56f9349dffe9420ba06ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f77dcc48b4b00618e0be340e6e4cbfe86f999c84c2ea36373a875c36cefbd4eb2d0262cfde5bc12036ac549bb1c3ee9ca90ec11ed13f6eb6504e3d0d32668f41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f55debd4f1423a4514e4698570fedc05f306265f2301dac8b2baa9fe86e66e9a111e6b07cd0414db9435935be4dc1ac2db6dc336573fd21b56fd807d89025c"} build_url:https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/JKuLNZ5CTY2p1Uk1wYvuqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48c5232fd938bc95a1b560e848e291333718cf00e8c624b309b10fabd7f0a90dd7c5e17e214f0822f2d87f4e2094cfcc31f857ed3f56f9349dffe9420ba06ac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f77dcc48b4b00618e0be340e6e4cbfe86f999c84c2ea36373a875c36cefbd4eb2d0262cfde5bc12036ac549bb1c3ee9ca90ec11ed13f6eb6504e3d0d32668f41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40f55debd4f1423a4514e4698570fedc05f306265f2301dac8b2baa9fe86e66e9a111e6b07cd0414db9435935be4dc1ac2db6dc336573fd21b56fd807d89025c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:36:42.719381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:36:42.719712) ========= 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=db0483c52d987ecb441a263b000001ad-1476980153.645625-1197461086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:36:42.803736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:36:42.804053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:36:42.804356) ========= ========= Total master_lag: 0.19 =========