builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1478817975.15 results: success (0) buildid: 20161110132855 builduid: a15840fc7fd84c2daac121181015788d revision: d38d06f85ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.152084) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.152550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.152836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.167853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.168122) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 14:46:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 588K=0.02s 2016-11-10 14:46:15 (588 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.377567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.377877) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013832 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:15.433159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-10 14:46:15.433511) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d38d06f85ef5 --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 d38d06f85ef5 --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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 14:46:15,957 Setting DEBUG logging. 2016-11-10 14:46:15,958 attempt 1/10 2016-11-10 14:46:15,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d38d06f85ef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 14:46:19,264 unpacking tar archive at: mozilla-central-d38d06f85ef5/testing/mozharness/ program finished with exit code 0 elapsedTime=3.610419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-10 14:46:19.058954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:19.059303) ========= script_repo_revision: d38d06f85ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:19.059721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:19.060016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 14:46:19.071055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-10 14:46:19.071471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:46:19 INFO - MultiFileLogger online at 20161110 14:46:19 in /builds/slave/test 14:46:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:46:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:46:19 INFO - {'append_to_log': False, 14:46:19 INFO - 'base_work_dir': '/builds/slave/test', 14:46:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:46:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:46:19 INFO - 'branch': 'Firefox-Non-PGO', 14:46:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:46:19 INFO - 'config_files': ('talos/linux_config.py',), 14:46:19 INFO - 'default_actions': ('clobber', 14:46:19 INFO - 'read-buildbot-config', 14:46:19 INFO - 'download-and-extract', 14:46:19 INFO - 'populate-webroot', 14:46:19 INFO - 'create-virtualenv', 14:46:19 INFO - 'install', 14:46:19 INFO - 'run-tests'), 14:46:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:46:19 INFO - 'download_minidump_stackwalk': True, 14:46:19 INFO - 'download_symbols': 'ondemand', 14:46:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:46:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:46:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:46:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:46:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:46:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:46:19 INFO - 'installer_path': 'installer.exe', 14:46:19 INFO - 'log_level': 'info', 14:46:19 INFO - 'log_name': 'talos', 14:46:19 INFO - 'log_to_console': True, 14:46:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:46:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:46:19 INFO - 'opt_config_files': (), 14:46:19 INFO - 'pip_index': False, 14:46:19 INFO - 'sps_profile': False, 14:46:19 INFO - 'sps_profile_interval': 0, 14:46:19 INFO - 'suite': 'dromaeojs', 14:46:19 INFO - 'system_bits': '32', 14:46:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:46:19 INFO - 'title': 'talos-linux64-ix-015', 14:46:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:46:19 INFO - 'use_talos_json': True, 14:46:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:46:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:46:19 INFO - 'work_dir': 'build'} 14:46:19 INFO - [mozharness: 2016-11-10 22:46:19.693155Z] Running clobber step. 14:46:19 INFO - Running pre-action listener: _resource_record_pre_action 14:46:19 INFO - Running main action method: clobber 14:46:19 INFO - rmtree: /builds/slave/test/build 14:46:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:46:20 INFO - Running post-action listener: _resource_record_post_action 14:46:20 INFO - [mozharness: 2016-11-10 22:46:20.769541Z] Finished clobber step (success) 14:46:20 INFO - [mozharness: 2016-11-10 22:46:20.769640Z] Running read-buildbot-config step. 14:46:20 INFO - Running pre-action listener: _resource_record_pre_action 14:46:20 INFO - Running main action method: read_buildbot_config 14:46:20 INFO - Using buildbot properties: 14:46:20 INFO - { 14:46:20 INFO - "project": "", 14:46:20 INFO - "product": "firefox", 14:46:20 INFO - "script_repo_revision": "production", 14:46:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:46:20 INFO - "repository": "", 14:46:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:46:20 INFO - "buildid": "20161110132855", 14:46:20 INFO - "pgo_build": "False", 14:46:20 INFO - "basedir": "/builds/slave/test", 14:46:20 INFO - "buildnumber": 295, 14:46:20 INFO - "slavename": "talos-linux64-ix-015", 14:46:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:46:20 INFO - "platform": "ubuntu64_hw", 14:46:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:46:20 INFO - "branch": "mozilla-central", 14:46:20 INFO - "repo_path": "mozilla-central", 14:46:20 INFO - "revision": "d38d06f85ef5", 14:46:20 INFO - "stage_platform": "linux64", 14:46:20 INFO - "builduid": "a15840fc7fd84c2daac121181015788d", 14:46:20 INFO - "slavebuilddir": "test" 14:46:20 INFO - } 14:46:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:46:20 INFO - Running post-action listener: _resource_record_post_action 14:46:20 INFO - [mozharness: 2016-11-10 22:46:20.772045Z] Finished read-buildbot-config step (success) 14:46:20 INFO - [mozharness: 2016-11-10 22:46:20.772145Z] Running download-and-extract step. 14:46:20 INFO - Running pre-action listener: _resource_record_pre_action 14:46:20 INFO - Running main action method: download_and_extract 14:46:20 INFO - mkdir: /builds/slave/test/build/tests 14:46: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')]} 14:46:20 INFO - trying https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:46:20 INFO - Downloading https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/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 14:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/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 14:46:21 INFO - Downloaded 1361 bytes. 14:46:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:46:21 INFO - Using the following test package requirements: 14:46:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:46:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:46:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:46:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'jsshell-linux-x86_64.zip'], 14:46:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:46:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:46:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:46:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:46:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:46:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:46:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:46:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:46:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:46:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:46:21 INFO - Fetch https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:46:21 INFO - Http code: 200 14:46:21 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:46:21 INFO - x-amz-cf-id: rQuVp760B-3WmlCTpAHkuL3gOC9cw6S10Rpi4mINblH7ODqUcsdrxA== 14:46:21 INFO - x-amz-version-id: AypwfN8DGBqmxGLUIakTfcythJeqSQb2 14:46:22 INFO - Expected file size: 20414063 14:46:22 INFO - Obtained file size: 20414063 14:46:26 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 14:46:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:46:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:46:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:46:26 INFO - Http code: 200 14:46:26 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 14:46:26 INFO - x-amz-cf-id: rgc4eEnTCwDLM89p5UQbEhzishe7qpCuVIk643LQ_IU6EdayCVNx8g== 14:46:26 INFO - x-amz-version-id: AypwfN8DGBqmxGLUIakTfcythJeqSQb2 14:46:27 INFO - Expected file size: 20414063 14:46:27 INFO - Obtained file size: 20414063 14:46:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:46:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:46:31 INFO - Fetch https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:46:31 INFO - Http code: 200 14:46:31 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 14:46:31 INFO - x-amz-cf-id: g081sWsIn9QQGAgeLQPWDt5WHI84qwyhME9P6fRYIH28ryVQe4sn7g== 14:46:31 INFO - x-amz-version-id: FYoWCLyXzSWma4bS8Mw7g2IHNPduNrmo 14:46:32 INFO - Expected file size: 14409038 14:46:32 INFO - Obtained file size: 14409038 14:46:32 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')]} 14:46:32 INFO - trying https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:46:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/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 14:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/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 14:46:33 INFO - Downloaded 55695615 bytes. 14:46:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:46:33 INFO - mkdir: /builds/slave/test/properties 14:46:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:46:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:46:33 INFO - Contents: 14:46:33 INFO - build_url:https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:46:34 INFO - Running post-action listener: _resource_record_post_action 14:46:34 INFO - Running post-action listener: set_extra_try_arguments 14:46:34 INFO - [mozharness: 2016-11-10 22:46:34.264648Z] Finished download-and-extract step (success) 14:46:34 INFO - [mozharness: 2016-11-10 22:46:34.264872Z] Running populate-webroot step. 14:46:34 INFO - Running pre-action listener: _resource_record_pre_action 14:46:34 INFO - Running main action method: populate_webroot 14:46:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:46:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:46:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:46:34 INFO - '--tppagecycles', 14:46:34 INFO - '7'], 14:46:34 INFO - 'tests': ['tsvgm']}}, 14:46:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:46:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:46:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:46:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:46:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['damp', 'tps']}, 14:46:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'tests': ['damp', 'tps']}, 14:46:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['dromaeo_dom']}, 14:46:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:46:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['basic_compositor_video']}, 14:46:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:46:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['a11yr', 14:46:34 INFO - 'ts_paint', 14:46:34 INFO - 'tpaint', 14:46:34 INFO - 'sessionrestore', 14:46:34 INFO - 'sessionrestore_no_auto_restore', 14:46:34 INFO - 'tabpaint']}, 14:46:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['tsvgx', 14:46:34 INFO - 'tsvgr_opacity', 14:46:34 INFO - 'tart', 14:46:34 INFO - 'tscrollx', 14:46:34 INFO - 'cart']}, 14:46:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:46:34 INFO - 'tsvgr_opacity', 14:46:34 INFO - 'tart', 14:46:34 INFO - 'tscrollx', 14:46:34 INFO - 'cart']}, 14:46:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'talos_options': ['--disable-e10s'], 14:46:34 INFO - 'tests': ['tp5o']}, 14:46:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'tests': ['tp5o']}, 14:46:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'talos_options': ['--disable-e10s', 14:46:34 INFO - '--xperf_path', 14:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:34 INFO - 'tests': ['tp5n']}, 14:46:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:34 INFO - 'talos_options': ['--xperf_path', 14:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:34 INFO - 'tests': ['tp5n']}}, 14:46:34 INFO - 'talos.zip': {'path': '', 14:46:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:46:34 INFO - Running post-action listener: _resource_record_post_action 14:46:34 INFO - [mozharness: 2016-11-10 22:46:34.280751Z] Finished populate-webroot step (success) 14:46:34 INFO - [mozharness: 2016-11-10 22:46:34.280838Z] Running create-virtualenv step. 14:46:34 INFO - Running pre-action listener: _resource_record_pre_action 14:46:34 INFO - Running main action method: create_virtualenv 14:46:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:46:34 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 14:46:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:46:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:46:34 INFO - Using real prefix '/usr' 14:46:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:46:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:46:36 INFO - Installing pip.................done. 14:46:36 INFO - Return code: 0 14:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:46:37 INFO - Reading from file tmpfile_stdout 14:46:37 INFO - Output received: 14:46:37 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) 14:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:37 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:37 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 14:46:37 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 14:46:37 INFO - Using env: {'DISPLAY': ':0', 14:46:37 INFO - 'HOME': '/home/cltbld', 14:46:37 INFO - 'LANG': 'en_US.UTF-8', 14:46:37 INFO - 'LANGUAGE': 'en_US:en', 14:46:37 INFO - 'LOGNAME': 'cltbld', 14:46:37 INFO - 'MAIL': '/var/mail/cltbld', 14:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:37 INFO - 'MOZ_NO_REMOTE': '1', 14:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:37 INFO - 'NO_EM_RESTART': '1', 14:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:37 INFO - 'PWD': '/builds/slave/test', 14:46:37 INFO - 'SHELL': '/bin/bash', 14:46:37 INFO - 'SHLVL': '1', 14:46:37 INFO - 'TERM': 'linux', 14:46:37 INFO - 'TMOUT': '86400', 14:46:37 INFO - 'USER': 'cltbld', 14:46:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:37 INFO - '_': '/tools/buildbot/bin/python'} 14:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:37 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 14:46:37 INFO - Cleaning up... 14:46:37 INFO - Return code: 0 14:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:37 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:37 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 14:46:37 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 14:46:37 INFO - Using env: {'DISPLAY': ':0', 14:46:37 INFO - 'HOME': '/home/cltbld', 14:46:37 INFO - 'LANG': 'en_US.UTF-8', 14:46:37 INFO - 'LANGUAGE': 'en_US:en', 14:46:37 INFO - 'LOGNAME': 'cltbld', 14:46:37 INFO - 'MAIL': '/var/mail/cltbld', 14:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:37 INFO - 'MOZ_NO_REMOTE': '1', 14:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:37 INFO - 'NO_EM_RESTART': '1', 14:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:37 INFO - 'PWD': '/builds/slave/test', 14:46:37 INFO - 'SHELL': '/bin/bash', 14:46:37 INFO - 'SHLVL': '1', 14:46:37 INFO - 'TERM': 'linux', 14:46:37 INFO - 'TMOUT': '86400', 14:46:37 INFO - 'USER': 'cltbld', 14:46:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:37 INFO - '_': '/tools/buildbot/bin/python'} 14:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:37 INFO - Downloading/unpacking psutil>=3.1.1 14:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:39 INFO - Installing collected packages: psutil 14:46:39 INFO - Running setup.py install for psutil 14:46:39 INFO - building 'psutil._psutil_linux' extension 14:46:39 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 14:46:39 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 14:46:39 INFO - building 'psutil._psutil_posix' extension 14:46:39 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 14:46:39 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 14:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:39 INFO - Successfully installed psutil 14:46:39 INFO - Cleaning up... 14:46:40 INFO - Return code: 0 14:46:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:40 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:40 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 14:46:40 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 14:46:40 INFO - Using env: {'DISPLAY': ':0', 14:46:40 INFO - 'HOME': '/home/cltbld', 14:46:40 INFO - 'LANG': 'en_US.UTF-8', 14:46:40 INFO - 'LANGUAGE': 'en_US:en', 14:46:40 INFO - 'LOGNAME': 'cltbld', 14:46:40 INFO - 'MAIL': '/var/mail/cltbld', 14:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:40 INFO - 'MOZ_NO_REMOTE': '1', 14:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:40 INFO - 'NO_EM_RESTART': '1', 14:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:40 INFO - 'PWD': '/builds/slave/test', 14:46:40 INFO - 'SHELL': '/bin/bash', 14:46:40 INFO - 'SHLVL': '1', 14:46:40 INFO - 'TERM': 'linux', 14:46:40 INFO - 'TMOUT': '86400', 14:46:40 INFO - 'USER': 'cltbld', 14:46:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:40 INFO - '_': '/tools/buildbot/bin/python'} 14:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:46:42 INFO - Installing collected packages: mozsystemmonitor 14:46:42 INFO - Running setup.py install for mozsystemmonitor 14:46:42 INFO - Successfully installed mozsystemmonitor 14:46:42 INFO - Cleaning up... 14:46:42 INFO - Return code: 0 14:46:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:42 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:42 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 14:46:42 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 14:46:42 INFO - Using env: {'DISPLAY': ':0', 14:46:42 INFO - 'HOME': '/home/cltbld', 14:46:42 INFO - 'LANG': 'en_US.UTF-8', 14:46:42 INFO - 'LANGUAGE': 'en_US:en', 14:46:42 INFO - 'LOGNAME': 'cltbld', 14:46:42 INFO - 'MAIL': '/var/mail/cltbld', 14:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:42 INFO - 'MOZ_NO_REMOTE': '1', 14:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:42 INFO - 'NO_EM_RESTART': '1', 14:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:42 INFO - 'PWD': '/builds/slave/test', 14:46:42 INFO - 'SHELL': '/bin/bash', 14:46:42 INFO - 'SHLVL': '1', 14:46:42 INFO - 'TERM': 'linux', 14:46:42 INFO - 'TMOUT': '86400', 14:46:42 INFO - 'USER': 'cltbld', 14:46:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:42 INFO - '_': '/tools/buildbot/bin/python'} 14:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:42 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 14:46:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:46:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:46:44 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 14:46:44 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 14:46:44 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 14:46:44 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 14:46:44 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 14:46:44 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 14:46:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:46:44 INFO - warning: no files found matching '*.txt' 14:46:44 INFO - no previously-included directories found matching 'build' 14:46:44 INFO - no previously-included directories found matching 'dist' 14:46:44 INFO - no previously-included directories found matching '.git*' 14:46:44 INFO - Installing collected packages: jsonschema, functools32 14:46:44 INFO - Running setup.py install for functools32 14:46:44 INFO - warning: no files found matching '*.txt' 14:46:44 INFO - no previously-included directories found matching 'build' 14:46:44 INFO - no previously-included directories found matching 'dist' 14:46:44 INFO - no previously-included directories found matching '.git*' 14:46:44 INFO - Successfully installed jsonschema functools32 14:46:44 INFO - Cleaning up... 14:46:45 INFO - Return code: 0 14:46:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:45 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:45 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 14:46:45 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 14:46:45 INFO - Using env: {'DISPLAY': ':0', 14:46:45 INFO - 'HOME': '/home/cltbld', 14:46:45 INFO - 'LANG': 'en_US.UTF-8', 14:46:45 INFO - 'LANGUAGE': 'en_US:en', 14:46:45 INFO - 'LOGNAME': 'cltbld', 14:46:45 INFO - 'MAIL': '/var/mail/cltbld', 14:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:45 INFO - 'MOZ_NO_REMOTE': '1', 14:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:45 INFO - 'NO_EM_RESTART': '1', 14:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:45 INFO - 'PWD': '/builds/slave/test', 14:46:45 INFO - 'SHELL': '/bin/bash', 14:46:45 INFO - 'SHLVL': '1', 14:46:45 INFO - 'TERM': 'linux', 14:46:45 INFO - 'TMOUT': '86400', 14:46:45 INFO - 'USER': 'cltbld', 14:46:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:45 INFO - '_': '/tools/buildbot/bin/python'} 14:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:46:45 INFO - Cleaning up... 14:46:45 INFO - Return code: 0 14:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:45 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:45 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 14:46:45 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 14:46:45 INFO - Using env: {'DISPLAY': ':0', 14:46:45 INFO - 'HOME': '/home/cltbld', 14:46:45 INFO - 'LANG': 'en_US.UTF-8', 14:46:45 INFO - 'LANGUAGE': 'en_US:en', 14:46:45 INFO - 'LOGNAME': 'cltbld', 14:46:45 INFO - 'MAIL': '/var/mail/cltbld', 14:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:45 INFO - 'MOZ_NO_REMOTE': '1', 14:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:45 INFO - 'NO_EM_RESTART': '1', 14:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:45 INFO - 'PWD': '/builds/slave/test', 14:46:45 INFO - 'SHELL': '/bin/bash', 14:46:45 INFO - 'SHLVL': '1', 14:46:45 INFO - 'TERM': 'linux', 14:46:45 INFO - 'TMOUT': '86400', 14:46:45 INFO - 'USER': 'cltbld', 14:46:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:45 INFO - '_': '/tools/buildbot/bin/python'} 14:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:46:45 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 14:46:45 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 14:46:45 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 14:46:45 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 14:46:45 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 14:46:45 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 14:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:46:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:46:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:47 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 14:46:48 INFO - Downloading docopt-0.6.1.tar.gz 14:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:46:48 INFO - Running setup.py install for blobuploader 14:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:46:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:46:48 INFO - Running setup.py install for requests 14:46:48 INFO - Running setup.py install for docopt 14:46:48 INFO - Successfully installed blobuploader requests docopt 14:46:48 INFO - Cleaning up... 14:46:48 INFO - Return code: 0 14:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:48 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')]} 14:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:48 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')]} 14:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:48 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:48 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 14:46:48 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 14:46:48 INFO - Using env: {'DISPLAY': ':0', 14:46:48 INFO - 'HOME': '/home/cltbld', 14:46:48 INFO - 'LANG': 'en_US.UTF-8', 14:46:48 INFO - 'LANGUAGE': 'en_US:en', 14:46:48 INFO - 'LOGNAME': 'cltbld', 14:46:48 INFO - 'MAIL': '/var/mail/cltbld', 14:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:48 INFO - 'MOZ_NO_REMOTE': '1', 14:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:48 INFO - 'NO_EM_RESTART': '1', 14:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:48 INFO - 'PWD': '/builds/slave/test', 14:46:48 INFO - 'SHELL': '/bin/bash', 14:46:48 INFO - 'SHLVL': '1', 14:46:48 INFO - 'TERM': 'linux', 14:46:48 INFO - 'TMOUT': '86400', 14:46:48 INFO - 'USER': 'cltbld', 14:46:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:48 INFO - '_': '/tools/buildbot/bin/python'} 14:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:46:48 INFO - Running setup.py (path:/tmp/pip-AKUwzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:46:49 INFO - Running setup.py (path:/tmp/pip-TtIPfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:46:49 INFO - Running setup.py (path:/tmp/pip-BlhiHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:46:49 INFO - Running setup.py (path:/tmp/pip-FI28Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:46:49 INFO - Running setup.py (path:/tmp/pip-grjfsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:46:49 INFO - Running setup.py (path:/tmp/pip-oJJBlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:46:49 INFO - Running setup.py (path:/tmp/pip-yzxHXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:46:49 INFO - Running setup.py (path:/tmp/pip-s5ntDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:46:49 INFO - Running setup.py (path:/tmp/pip-qjos3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:46:49 INFO - Running setup.py (path:/tmp/pip-4TNWlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:46:49 INFO - Running setup.py (path:/tmp/pip-4sL6AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:46:49 INFO - Running setup.py (path:/tmp/pip-f5Belt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:46:49 INFO - Running setup.py (path:/tmp/pip-3qN0CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:46:49 INFO - Running setup.py (path:/tmp/pip-1wiR3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:49 INFO - Running setup.py (path:/tmp/pip-W3r5Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:46:50 INFO - Running setup.py (path:/tmp/pip-BbgYII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:46:50 INFO - Running setup.py (path:/tmp/pip-RZIKmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:46:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:46:50 INFO - Running setup.py install for manifestparser 14:46:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Running setup.py install for mozcrash 14:46:50 INFO - Running setup.py install for mozdebug 14:46:50 INFO - Running setup.py install for mozdevice 14:46:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Running setup.py install for mozfile 14:46:50 INFO - Running setup.py install for mozhttpd 14:46:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Running setup.py install for mozinfo 14:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Running setup.py install for mozInstall 14:46:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:46:50 INFO - Running setup.py install for mozleak 14:46:51 INFO - Running setup.py install for mozlog 14:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Running setup.py install for moznetwork 14:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Running setup.py install for mozprocess 14:46:51 INFO - Running setup.py install for mozprofile 14:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Running setup.py install for mozrunner 14:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Running setup.py install for mozscreenshot 14:46:51 INFO - Running setup.py install for moztest 14:46:51 INFO - Running setup.py install for mozversion 14:46:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:46:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:46:51 INFO - Cleaning up... 14:46:51 INFO - Return code: 0 14:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:52 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:52 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 14:46:52 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 14:46:52 INFO - Using env: {'DISPLAY': ':0', 14:46:52 INFO - 'HOME': '/home/cltbld', 14:46:52 INFO - 'LANG': 'en_US.UTF-8', 14:46:52 INFO - 'LANGUAGE': 'en_US:en', 14:46:52 INFO - 'LOGNAME': 'cltbld', 14:46:52 INFO - 'MAIL': '/var/mail/cltbld', 14:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:52 INFO - 'MOZ_NO_REMOTE': '1', 14:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:52 INFO - 'NO_EM_RESTART': '1', 14:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:52 INFO - 'PWD': '/builds/slave/test', 14:46:52 INFO - 'SHELL': '/bin/bash', 14:46:52 INFO - 'SHLVL': '1', 14:46:52 INFO - 'TERM': 'linux', 14:46:52 INFO - 'TMOUT': '86400', 14:46:52 INFO - 'USER': 'cltbld', 14:46:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:52 INFO - '_': '/tools/buildbot/bin/python'} 14:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:46:52 INFO - Running setup.py (path:/tmp/pip-yoyaS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:46:52 INFO - Running setup.py (path:/tmp/pip-gQ9FrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:46:52 INFO - Running setup.py (path:/tmp/pip-HsJQ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:46:52 INFO - Running setup.py (path:/tmp/pip-oBRx3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:46:52 INFO - Running setup.py (path:/tmp/pip-Dxue_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:46:52 INFO - Running setup.py (path:/tmp/pip-Esm3w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:46:52 INFO - Running setup.py (path:/tmp/pip-Z2fKCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:46:52 INFO - Running setup.py (path:/tmp/pip-KSzOB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:46:52 INFO - Running setup.py (path:/tmp/pip-4haWvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:46:52 INFO - Running setup.py (path:/tmp/pip-49O3Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:46:52 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)) 14:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:46:52 INFO - Running setup.py (path:/tmp/pip-tn0Et_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:46:53 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)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:46:53 INFO - Running setup.py (path:/tmp/pip-e2sMp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:46:53 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)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:46:53 INFO - Running setup.py (path:/tmp/pip-E7yz3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:46:53 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)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:46:53 INFO - Running setup.py (path:/tmp/pip-LZVl_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:53 INFO - Running setup.py (path:/tmp/pip-P_2o8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:53 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)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:46:53 INFO - Running setup.py (path:/tmp/pip-OUWffO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:46:53 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)) 14:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:46:53 INFO - Running setup.py (path:/tmp/pip-xSWHn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:46:53 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)) 14:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:46:53 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)) 14:46:53 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)) 14:46:53 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)) 14:46:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:46:53 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 14:46:53 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 14:46:53 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 14:46:53 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 14:46:53 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 14:46:53 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 14:46:55 INFO - Downloading blessings-1.6.tar.gz 14:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:46:55 INFO - Installing collected packages: blessings 14:46:55 INFO - Running setup.py install for blessings 14:46:55 INFO - Successfully installed blessings 14:46:55 INFO - Cleaning up... 14:46:55 INFO - Return code: 0 14:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:55 INFO - Reading from file tmpfile_stdout 14:46:55 INFO - Current package versions: 14:46:55 INFO - argparse == 1.2.1 14:46:55 INFO - blessings == 1.6 14:46:55 INFO - blobuploader == 1.2.4 14:46:55 INFO - docopt == 0.6.1 14:46:55 INFO - functools32 == 3.2.3-2 14:46:55 INFO - jsonschema == 2.5.1 14:46:55 INFO - manifestparser == 1.1 14:46:55 INFO - mozInstall == 1.12 14:46:55 INFO - mozcrash == 1.0 14:46:55 INFO - mozdebug == 0.1 14:46:55 INFO - mozdevice == 0.48 14:46:55 INFO - mozfile == 1.2 14:46:55 INFO - mozhttpd == 0.7 14:46:55 INFO - mozinfo == 0.9 14:46:55 INFO - mozleak == 0.1 14:46:55 INFO - mozlog == 3.4 14:46:55 INFO - moznetwork == 0.27 14:46:55 INFO - mozprocess == 0.23 14:46:55 INFO - mozprofile == 0.28 14:46:55 INFO - mozrunner == 6.13 14:46:55 INFO - mozscreenshot == 0.1 14:46:55 INFO - mozsystemmonitor == 0.3 14:46:55 INFO - moztest == 0.7 14:46:55 INFO - mozversion == 1.4 14:46:55 INFO - psutil == 3.1.1 14:46:55 INFO - requests == 1.2.3 14:46:55 INFO - wsgiref == 0.1.2 14:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:55 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:55 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 14:46:55 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 14:46:55 INFO - Using env: {'DISPLAY': ':0', 14:46:55 INFO - 'HOME': '/home/cltbld', 14:46:55 INFO - 'LANG': 'en_US.UTF-8', 14:46:55 INFO - 'LANGUAGE': 'en_US:en', 14:46:55 INFO - 'LOGNAME': 'cltbld', 14:46:55 INFO - 'MAIL': '/var/mail/cltbld', 14:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:55 INFO - 'MOZ_NO_REMOTE': '1', 14:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:55 INFO - 'NO_EM_RESTART': '1', 14:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:55 INFO - 'PWD': '/builds/slave/test', 14:46:55 INFO - 'SHELL': '/bin/bash', 14:46:55 INFO - 'SHLVL': '1', 14:46:55 INFO - 'TERM': 'linux', 14:46:55 INFO - 'TMOUT': '86400', 14:46:55 INFO - 'USER': 'cltbld', 14:46:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:55 INFO - '_': '/tools/buildbot/bin/python'} 14:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 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)) 14:46:56 INFO - Cleaning up... 14:46:56 INFO - Return code: 0 14:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:56 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 0x7f8a390bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', '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 14:46:56 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 14:46:56 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 14:46:56 INFO - Using env: {'DISPLAY': ':0', 14:46:56 INFO - 'HOME': '/home/cltbld', 14:46:56 INFO - 'LANG': 'en_US.UTF-8', 14:46:56 INFO - 'LANGUAGE': 'en_US:en', 14:46:56 INFO - 'LOGNAME': 'cltbld', 14:46:56 INFO - 'MAIL': '/var/mail/cltbld', 14:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:56 INFO - 'MOZ_NO_REMOTE': '1', 14:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:56 INFO - 'NO_EM_RESTART': '1', 14:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:56 INFO - 'PWD': '/builds/slave/test', 14:46:56 INFO - 'SHELL': '/bin/bash', 14:46:56 INFO - 'SHLVL': '1', 14:46:56 INFO - 'TERM': 'linux', 14:46:56 INFO - 'TMOUT': '86400', 14:46:56 INFO - 'USER': 'cltbld', 14:46:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:56 INFO - '_': '/tools/buildbot/bin/python'} 14:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:46:56 INFO - Cleaning up... 14:46:56 INFO - Return code: 0 14:46:56 INFO - Running post-action listener: _resource_record_post_action 14:46:56 INFO - Running post-action listener: _start_resource_monitoring 14:46:56 INFO - Starting resource monitoring. 14:46:56 INFO - [mozharness: 2016-11-10 22:46:56.329568Z] Finished create-virtualenv step (success) 14:46:56 INFO - [mozharness: 2016-11-10 22:46:56.330023Z] Running install step. 14:46:56 INFO - Running pre-action listener: _resource_record_pre_action 14:46:56 INFO - Running main action method: install 14:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:46:56 INFO - Reading from file tmpfile_stdout 14:46:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:46:56 INFO - Reading from file tmpfile_stdout 14:46:56 INFO - Output received: 14:46:56 INFO - Usage: mozinstall [options] installer 14:46:56 INFO - Options: 14:46:56 INFO - -h, --help show this help message and exit 14:46:56 INFO - -d DEST, --destination=DEST 14:46:56 INFO - Directory to install application into. [default: 14:46:56 INFO - "/builds/slave/test"] 14:46:56 INFO - --app=APP Application being installed. [default: firefox] 14:46:56 INFO - mkdir: /builds/slave/test/build/application 14:46:56 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'] 14:46:56 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 14:47:12 INFO - Reading from file tmpfile_stdout 14:47:12 INFO - Output received: 14:47:12 INFO - /builds/slave/test/build/application/firefox/firefox 14:47:12 INFO - Running post-action listener: _resource_record_post_action 14:47:12 INFO - [mozharness: 2016-11-10 22:47:12.658174Z] Finished install step (success) 14:47:12 INFO - [mozharness: 2016-11-10 22:47:12.658415Z] Running run-tests step. 14:47:12 INFO - Running pre-action listener: _resource_record_pre_action 14:47:12 INFO - Running main action method: run_tests 14:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:47:12 INFO - Python 2.7.3 14:47:12 INFO - Return code: 0 14:47:12 INFO - grabbing minidump binary from tooltool 14:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:12 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 0x1fd7f60>, '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 0x1fd8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:47:12 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 14:47:12 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 14:47:12 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 14:47:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:47:12 INFO - Return code: 0 14:47:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:47:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:47:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:47:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:47:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:47:12 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:47:12 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:47:12 INFO - Using env: {'DISPLAY': ':0', 14:47:12 INFO - 'HOME': '/home/cltbld', 14:47:12 INFO - 'LANG': 'en_US.UTF-8', 14:47:12 INFO - 'LANGUAGE': 'en_US:en', 14:47:12 INFO - 'LOGNAME': 'cltbld', 14:47:12 INFO - 'MAIL': '/var/mail/cltbld', 14:47:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:47:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:12 INFO - 'MOZ_NO_REMOTE': '1', 14:47:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:12 INFO - 'NO_EM_RESTART': '1', 14:47:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:12 INFO - 'PWD': '/builds/slave/test', 14:47:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:47:12 INFO - 'SHELL': '/bin/bash', 14:47:12 INFO - 'SHLVL': '1', 14:47:12 INFO - 'TERM': 'linux', 14:47:12 INFO - 'TMOUT': '86400', 14:47:12 INFO - 'USER': 'cltbld', 14:47:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495', 14:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:12 INFO - '_': '/tools/buildbot/bin/python'} 14:47:12 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:47:12 INFO - mozversion application_buildid: 20161110132855 14:47:12 INFO - mozversion application_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 14:47:12 INFO - mozversion application_display_name: Nightly 14:47:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:47:12 INFO - mozversion application_name: Firefox 14:47:12 INFO - mozversion application_remotingname: firefox 14:47:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:47:12 INFO - mozversion application_vendor: Mozilla 14:47:12 INFO - mozversion application_version: 52.0a1 14:47:12 INFO - mozversion platform_buildid: 20161110132855 14:47:12 INFO - mozversion platform_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 14:47:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:47:12 INFO - mozversion platform_version: 52.0a1 14:47:12 INFO - using testdate: 1478818032 14:47:12 INFO - actual date: 1478818032 14:47:12 INFO - starting webserver on 'localhost:54118' 14:47:12 INFO - SUITE-START | Running 2 tests 14:47:12 INFO - TEST-START | dromaeo_css 14:47:12 INFO - operating with platform_type : linux_ 14:47:12 INFO - Initialising browser for dromaeo_css test... 14:47:12 INFO - TEST-INFO | started process 4927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwq9n00/profile http://localhost:54118/getInfo.html) 14:47:17 INFO - PROCESS | 4927 | __metrics Screen width/height:1600/1200 14:47:17 INFO - PROCESS | 4927 | colorDepth:24 14:47:17 INFO - PROCESS | 4927 | Browser inner width/height: 1024/697 14:47:17 INFO - PROCESS | 4927 | __metrics 14:47:17 INFO - PROCESS | 4927 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:47:17 INFO - PROCESS | 4927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:19 INFO - TEST-INFO | 4927: exit 0 14:47:19 INFO - Browser initialized. 14:47:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:47:19 INFO - TEST-INFO | started process 5011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwq9n00/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:31 INFO - PROCESS | 5011 | RSS: Main: 173727744 14:47:31 INFO - PROCESS | 5011 | 14:48:23 INFO - PROCESS | 5011 | 1478818103111 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] 14:50:35 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54118/tests/dromaeo/cssquery-ext.html) 14:50:38 INFO - PROCESS | 5011 | RSS: Main: 386064384 14:50:38 INFO - PROCESS | 5011 | 14:53:41 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-ext.html (next: http://localhost:54118/tests/dromaeo/cssquery-jquery.html) 14:53:42 INFO - PROCESS | 5011 | RSS: Main: 285593600 14:53:42 INFO - PROCESS | 5011 | 14:56:44 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54118/tests/dromaeo/cssquery-mootools.html) 14:56:44 INFO - PROCESS | 5011 | RSS: Main: 222011392 14:56:44 INFO - PROCESS | 5011 | 14:59:47 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54118/tests/dromaeo/cssquery-prototype.html) 14:59:47 INFO - PROCESS | 5011 | RSS: Main: 220790784 14:59:47 INFO - PROCESS | 5011 | 15:02:50 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54118/tests/dromaeo/cssquery-yui.html) 15:02:51 INFO - PROCESS | 5011 | RSS: Main: 223686656 15:02:51 INFO - PROCESS | 5011 | 15:05:54 INFO - PROCESS | 5011 | Cycle 1(1): loaded http://localhost:54118/tests/dromaeo/cssquery-yui.html (next: http://localhost:54118/tests/dromaeo/cssquery-dojo.html) 15:05:55 INFO - PROCESS | 5011 | RSS: Main: 308240384 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | __start_tp_report 15:05:55 INFO - PROCESS | 5011 | _x_x_mozilla_page_load 15:05:55 INFO - PROCESS | 5011 | _x_x_mozilla_page_load_details 15:05:55 INFO - PROCESS | 5011 | |i|pagename|runs| 15:05:55 INFO - PROCESS | 5011 | |0;dojo.html;2581.5224183526047;2588.805839562033;2597.844129352239;2616.3589920469462;2651.7348265173487;4503;4579.038401935598;4672.299155126732;4682.719036857787;4709.529047095289;4619.653525985547;4633.582977532022;4639.953600463994;4648.907021859561;4649.6047835933905;4247.044415006622;4270.252705776492;4287.7856107194675;4309.913801723964;4350.4344435223375;4329.696921215516;4330.588594083557;4335;4335.219660461115;4349.456317960255;4235.745855248695;4259.70182087254;4305.203537345586;4305.634021108194;4341.826326946934;4360.040791025969;4362.345648152771;4362.934555981663;4364.912701745948;4370.2352088384405;4138.979305103485;4164.250434921712;4171.040660648037;4277.8288868445225;4279.144171165779;4582.679212455096;4591.586757191869;4595.471520775087;4597.781135676768;4622.098690755271;4896.192128298826;4903.092927808367;4917.262410638397;4918.114739346916;4948.901021979576;4788.257820037899;4833.130036593447;4835.1296766582;4963.627727920384;5005.449400565934;4564.817407303737;4575.93136102952;4598.034412773288;4620.422447194101;4668.85993420198;5041.319421878073;5043.041822053798;5043.722595257223;5049.545540901337;5094.745262736848;4738.218193998021;4823.03539292143;4828.155072862235;4841.806327746921;4893.584045356185;4882.609391248691;4937.308776771255;4959.479254678206;4982.103221420107;4983.6760610560195;4935.210366341368;4945.357103576512;4947.6289278304275;4979.253112033224;4992.2511623256805;4884.1941079722155;4906.90186196274;4908.558229759267;4909.337239472697;4955.925661115086;4005.599440055971;4019.738716983387;4059.6346328829954;4071.941295263253;4149.128682976549;3580;3622.4385220290897;3645.65366290202;3648.7628304160144;3649.908752281214;4257.723247988871;4279.529251782302;4287.935680964788;4298.591633794785;4332.718373305725;4834.661573689878;4879.463259041502;4946.604271658331;4955.083309587738;4995.750212489361;4263.637590804754;4270.530241673413;4277.101808620225;4281.935770963376;4325.15659446405;4469.7988590513505;4470.1059788041875;4503.347014682852;4510.323451482304;4511.684182107221;4662.906741865144;4671.392718946515;4674.5091765365505;4680.531946805292;4726.19654658702;4820;4880.097182021195;4887.584555312838;4998.075356059141;5004.924926126038;4619.69971951822;4658.627309815274;4661.440627124767;4662.883427914329;4691.413573303337;4888.7311197884455;4896.6572339935865;4899.1426500363;4901.950980490149;4956.083124621957;4835.927461088157;4917.139500587455;4942.20924652054;4971.453140154653;5020.046191223656;4764.618830493621;4822.831200907952;4823.252395878644;4824.758762061953;4826.517348265145;4766.547178018082;4790.7365094920115;4810.783514741775;4814.253790662453;4823.782929768098;4715.434147902273;4736.313234581035;4740.312654665123;4744.1697702901165;4749.311349854321;4844.539768721966;4845.563899249085;4857.028594281087;4859.1010663027455;4861.440934292602;4715.905681886412;4729.054189162112;4749.525047495223;4757.286407038971;4762.547557981986 15:05:55 INFO - PROCESS | 5011 | |1;ext.html;550.9504144626983;570.8230448560946;582.8222392170389;584.0567483514126;594.9048152295634;29468;38256.42615360768;39266.99999999996;39401.40897886527;43405.34891976623;38923.221535569275;39179;39218.411723824094;39271.21457570854;39278.41082383759;7238.529495582797;7422.257774222575;7565.243475652445;7565.886511702329;7568.205338439468;7053.224145344008;7273.054502914641;7275.381592564612;7283.672234749449;9558.952205238964;9581.473018983954;9892.752681182956;9899.059589339036;9899.15857152143;9903.10872021518;9731.318807683465;9790.363626364298;9792.657256996043;9797.31418800677;9810.558524866326;9663;9701.70894873155;9735.610575576968;9736;9738.367006144577;36413.63586364155;36886.44670329947;36919.446208306894;37061.81469092664;37096.258074838624;2943.499605067144;2950.822950622948;2979.970200297991;2984.5373967035143;3280.7867488613165;26826;26834.5974810378;26851.86574067117;27625;28117.718822811716;3456.2050728332374;3474.1314671332166;3480.443129099357;3598.874039408608;3647.8176091195332;237874;238164;238359;238394;239622;48879.02241955141;49029.116506019505;49046.26430603544;49381.506184937694;49386;30978.225544361572;31852.522212166838;31962;32523.837380812944;32689.673103268662;14601.488947886774;14831.851681483264;14858.851411485746;14862.331195096247;14868.628284292763;11215.271007384494;11359;11397.601083962187;11399.772004559862;11406.714832129263;11531.711707207387;11905.226160299553;16602.683302341236;16953.745693814602;17331.30674772995;6439.034144878306;6520.576162549419;6611.669416529155;6677.732890684415;6851.07510486088;782.4679218131612;839.5298632765671;863.5034854958424;930.8557173637962;960.4772557792692;25839.870800645876;26944.865275673495;27135.10767069641;27323.726762732516;27484.312892177855;913.3880300198882;957.6648173139346;999.3654029691053;1015.6343716262139;1015.8476228565627;14382.568522944328;14537.563873083824;14664.926675366554;14675.266236688123;14766.187859667607;344405;348818;349578;349912;352097;45335.14651254614;46570;47310;48426;48443.51556484461;1169.6958790714305;1174.17220859294;1187.0978056676815;1200.8378868852767;1212.1393810394718;26141.346466338495;27333.589996150473;27623.171304860887;27921;28150.43699126047;39469.40795888122;45569.772151139034;46989.53010469989;51675;51936;297660;298930;300726;301325;301452;36348;36874.44688329624;37029.814850926654;37221.25557488781;37535.249295014495;39846.800765995984;40492.595074048884;40673.38989915213;40776.796116020414;41210.1757964833;34660.65339346574;34734.65265347314;34753.13117172091;34932.65067349294;35129.64870351264;34566.30867382688;34870.825645871606;34909.82545087258;35086.47370289499;35305.764298249436;33705;34211.14472138217;34685.306293874484;34922.12694682653;35276.29447410986;29866.552001720425;31470.52794208043;31501;31548;31661;23246.76753232446;24673.136440224505;24872.875635621705;25038.74961250364;25050.498990020464 15:05:55 INFO - PROCESS | 5011 | |2;jquery.html;293.58897543439195;315.37581455504136;319.0268191237198;332.0917291208545;339.66373290442453;12382.133250672445;15296.617584560392;16031.67936641268;16749.83250167498;16991.57521061974;15212.163331016789;15693.136877471734;15830.445934392299;16649.50051498454;16970.915145424286;3611.3319035978298;4513.977430112853;4672.205725026736;4677.4620918594455;5195.532402083812;5043.445221025684;5122.897542049157;5123.129068058421;5123.846284611449;5131.307273518083;4866.635002374818;5058.822941197059;5083.703655567843;5094.9045955119645;5102.872428189288;4950.727709975949;4977.15388383972;4984.3021976923255;4985.227289770091;4985.675931064469;4347.413099231627;4499.055198408339;4512.165249428866;4517.164324599959;4518.932216016729;10793.83809242862;12153.817692734616;12211.389430528438;12221.388930553525;12233.449494772756;1821.817818218181;1826.3151318255655;1886.1135266424758;1887.5186827359073;2035.847311451647;8841.911580884173;8848.380613357067;9037.774055648595;9257.490838003907;11128.38793866337;1634.1012443156335;1665.1341302522742;1720.4666553368495;1773.689604319239;1782.9956523258352;58520;66553;66582.3341766581;68455;69151.65424172897;9168.679096231599;9418.529073546433;9420.858687119699;9628.085331893599;10044.849327260097;10473.528691208761;11181.608643697431;12585.685357866127;13603.455861765418;13636.113652612548;7292.868223221038;7344.228855970153;7369.520981136209;7378.483506154517;7499.662515186829;6964.582125072512;6970.233274339818;7180.138383394026;7186.92813071873;7197.604131772698;4023.5372932112596;4070.6946978976694;4122.587741225853;4293.291606884892;4320.848770293024;1600.9679806403806;1668.7163182259046;1675.1875340459867;1684.2505085237196;1686.5446329491215;800.7437619961556;875.6584931876573;882.3117967984982;896.7533928169805;915.1809130827871;16235.756463653055;16510.33958641665;16649.16754162287;16708.58228544296;17330.566735831453;816.0452270843009;855.8117214212863;859.7635650196121;860.4708104515678;867.0808942520948;8855.557222138867;9588.616455341848;9652.420854748738;9659.758506037264;9816.165625921876;346982.1337519099;359804.6029309562;383669;386766;389454;72308.63845680738;73870.1355837303;74201.38576442018;77571;78792.24227152023;848.5841937450729;867.6616119713191;871.3813192633302;872.6814712629845;875.282268539804;14698.706025879637;14715.117092974457;15078.698426031637;15148.242587870784;15283.636670790329;35973.82013089918;36130.27739445144;36377;36884.81557592195;37322.253554929295;48769;48774.512254876994;48923;49178.75410622924;49229.507704923926;7345.375643070399;7361.852762944604;7442.92557074444;7499.100107987077;7711.537307761552;8395;10610.514527966245;10815.172727902796;12024.939875300568;12065.758684826429;10132;10147.594096236067;10527.315724477885;10769.407682577534;10840.67477975662;10345.224108191765;10482.947585262025;10557.472126393495;10564.366138031743;10621.256512044392;10214.387136771817;10469.476526173508;10652.57389704403;10662;11392.886071139183;6330.841728956629;6713.295104014008;6743.763968261087;6938.791836244921;7779.72770953014;4950.529699678525;8191.959040204761;9706.5146742664;10283.200439923134;10891.98498277821 15:05:55 INFO - PROCESS | 5011 | |3;mootools.html;1182.2256422043565;1274.2227241382755;1322.8015797630355;1324.9735005299895;1626.9023858568487;5811.680357580337;6416.518761092919;6606.636634985074;6609.7025633846415;6771.932280677192;6672;6724.764633237838;6730.528862979593;6736.191657001166;6741.157355330583;2017.9697304540443;2038.6432374334431;2043.8671486353414;2045.826104781088;2047.4062521868714;1973.289615738333;2030.0255877178963;2045.3557129504234;2050.159434631801;2052.384284714587;1925.711143328505;1945.5525229197292;1960.892150931698;1965.439849642852;1966.8426525877896;1926.0562324460984;1941.932032378874;1943.8542109341856;1945.251078334837;1945.9416217513497;1841.815818418161;1867.953301167468;1871.9251229950785;1881.698928171486;1884;6650;6697.564658297195;6707.195136583641;6714.731410743564;6725.159355080615;4088.509378874554;4292.1415716856445;4293.592108749695;4294.527601963813;4295.377170310318;2564.4230048239183;2743.396452780385;2802.5095608268675;2804.5372513535244;2806.8736906839035;815.1481701621819;840.0633293877344;845.5096044294295;860.036758830108;872.4111224923151;8830.293576513928;8938.106189381075;8945.418547794372;8983.505907175102;8986.41588296765;3494.6910793412003;3517.8592856285463;3581.8746343877838;3671.155634204148;3686.5391826021746;7066.222715501291;7070.646467676595;7074.080369552028;7078.0444639973975;7087.220405755363;4099.487564054493;4108.568600296986;4110.424540564323;4112.938305925413;4113.814878330482;3220.0983724557163;3333.599968003855;3607.0801945504254;3744.588095309514;3826.1773718650625;2869;2884.1059271625863;2963.866626001835;2990.2673844908136;3005.113491520007;843.325339728215;867.7223288547731;875.7810547363159;881.9823603527893;882.5057967538199;690.4993879437368;695.5861262548775;707.5648476187108;809;846.7121178799115;4572.81708731647;4812.181929072066;4815.975920120377;4845.781939812717;5017.724025178651;369.1951545630551;383.1360282562803;385.0777388155352;390.3111009068995;396.869033219037;3286.342731453719;3426.1434641339665;3430.4168291390524;3461.5153878457036;3566;7699.422543309274;8181.836363272821;8187.672493100328;8198.672053117809;8213.055498617736;8122.959385203036;8134.593270336578;8138.511689298661;8139.715109971123;8146.592670366458;6196.721147548371;6302.842428939313;6412.711427985845;6416.7754128605275;6417.326180751047;4736.336912832275;4740.691855029412;4791.952080479151;4796.688215265996;4839.95160048395;7476.663550140365;7484.476086673881;7603.46775725716;7608.087029556488;7610.467267291458;7638.197989211275;7713.382929365525;7726.42051846125;7729.613519324123;7764.456488045783;5652.039153343859;5708.372079071216;5714.228579141929;5714.857128571819;5715.771369145187;5721.456461636138;5789.652620842763;6564.770233041821;6610.70251838678;6718.596884186964;5658.801941932177;5751.4536119068625;5764.827055188351;5793.275840519935;5981.790637327673;5868.677222752619;6016.458518733335;6038.818835434944;6044.576879618385;6114.785982490592;5298.072837253389;5434.619576629598;5456.154296084113;5581.441855814386;5648.548116150616;4160.355144952538;4204.600562946515;4228.9788551057045;4263.616274535307;4268.2530557152995;4059.4722686050623;4090.7114259008317;4161.791910404529;4179.6029377209115;4188.91622167561 15:05:55 INFO - PROCESS | 5011 | |4;prototype.html;273.6825282672101;276.3133612971766;280.8208303564341;281.65369533629257;285.9056511351253;4752.714837109772;4753.382060332161;4757.238841785315;4760.8097975506125;4767.761611919404;4687.88280292992;4701.929471057937;4707.62339012879;4719.764011799413;4721.834735784249;3459.3427248822645;3557.861484325017;3559.3059353426092;3566.7681600696;3689.262147570497;3665.083729067733;3678.209185025219;3685.778853268799;3690.9630903691022;3699.5190625218684;3638.108663377476;3649.2701459708032;3654.7441679082476;3655.1593133579295;3661.4507823826507;3487.8953631390973;3569.625189355132;3594.8202589870534;3674.228412033476;3680.871169509081;3193.8562764675644;3200.983995080033;3209.3581283743347;3211.807291562514;3245.496947973068;4502.93245601313;4505.346724724929;4506.188886000518;4517.40249356618;4537.636989040901;3969.6030396960364;4127.711060225785;4129.587041295877;4138.296489596745;4145.274576949022;4847.927281090751;4862.17343051682;4866.197077482211;4869.537393947605;4871.318015477836;3531.593866705336;3532.205253817896;3534.2224710563637;3534.3638145133864;3536.1513236823234;4952.182889823211;5087;5087.79648814047;5095.821646242363;5111.974440127776;3570.6429357064603;3592.7844329340323;3592.892213233607;3605.531280933514;3617.981910090433;3642.817859107034;3647.9817600911824;3651.561812582454;3661.41417373219;3663.432168013962;4151.12826306473;4152.750834949852;4158.126793373365;4161.459010328638;4174.248635245624;4750.904981900343;4836.250381190921;4865.148598995162;4910.386201724785;4912.852614421573;1220.1032241302635;1225.7629825568374;1227.5089964014467;1231.8644949055597;1236.8268442418068;810.295043312322;822.7572866004543;837.4347315562093;837.9832403351899;848.3510114762212;4178.749275043447;4254.298040823292;4380.474343078851;4384.7369157850635;4392.363107349416;5044.066847633199;5072.51811077947;5076.416212135578;5078.771455284521;5082.263071854561;4387.5393083726385;4399.912001759947;4400.437844565134;4408.4930233023615;4424.75663838492;2479.9752002480104;2595.091717898758;2599.4281258123183;2600.609908513738;2622.41343986889;4570.360149579062;4597.747123908217;4605.217113090783;4621.468531118964;4643.907121857544;4928.383952005999;4972.353594032753;4983.6760610560195;5021.472745361758;5031.371078615173;4454.287314029804;4769.9046019080115;4791.736454495036;4808.773762690562;4812.35033270504;5109.437961824122;5117.718525481134;5125.283599692169;5129.9743501282255;5147.794088236428;4872.244802055687;5013.598912087097;5016.147254966738;5029.346184995927;5034.672746271481;4738.431388233434;4773.164696178224;4810.855674329776;4818.277258411266;4824.782884770124;3498.422760244633;3506.8772592959126;3514.4728290756593;3517.577890653138;3520.1903562181355;5102.464241254764;5103.540681338697;5111.718855462986;5124.282600435868;5144.116192274809;4793.5446132618745;4886.560209581155;4904.460509343898;4924.532169443897;4949.554540091409;4883.267509873547;4914.36113305268;4919.631027672867;4926.630502712239;4936.901261974812;4847.61219102478;4864.489228630943;4874.878128046827;4876.609871210224;4876.78054487556;4779.657967595923;4928.349003083864;4982.377202849644;4986.501349864984;4990.176620857663;4860.9513904861915;4863.562279394871;4869.391326084239;4872.052408292931;4878.0975519529 15:05:55 INFO - PROCESS | 5011 | |5;yui.html;640.9455196308313;667.5360624366065;668.7793028300658;679.6465837764359;701.1551080947457;11931.343776092323;12763.617091487247;12769.553065642704;12778.424970876298;12779.680507987305;11997.640070797868;12043.156979011474;12056.095792815551;12130.93934530326;12142.150049496538;593.9249957576778;611.3672349118663;742.7771668499455;749.763824395315;759.9050118735158;753.4951582439751;758.260695821575;761.0828951113895;761.0828951113922;761.6686741267539;791.5329955326356;797.4776521378477;797.5732982854174;797.6689673785401;799.1648727080216;631.5421319543341;647.805658302512;778.0468925566192;795.3637090327744;797.8045378882211;590.1619700025973;590.8020813027598;590.9970450147765;591.03956071384;591.3583761618648;11933.641990740292;11954.820677689842;11964.04287656994;11974.401279935968;11974.940125299318;11087.778244435147;11300.943495282554;11305.321680699102;11385.259958102697;11676.708082297926;10479.318844275174;10691.358518488838;10722.571097156104;10727.624533141381;10795;3947.695273298145;3957.762534247954;3971.0667993021616;4021.416894550303;4039.9900024993754;46440.76779616114;47512;48074.519254807354;48111.278330825415;48442.515574844154;8912.465252084767;9026;9162.123643322047;9234.984151743303;9605.663801767045;16166.919165404097;16221.2700428481;16267.593310167103;16281.51155465338;16370.508884733477;6282.654454005074;6324.33594472583;6365.013422919455;6396;6457.999010153434;3380.8478618462227;3407.591089069278;3451.7928924264625;3459.723222142273;3469.7050750686476;2425.8180636451984;2494.9376265593505;2516.0564788204424;2520;2520.899164033455;443.4191209515545;446.5869071109211;449.5324862143334;452.27861560810453;458.6216371493531;467.1731036066144;502.97485125743566;537.8278950735805;556.5158312268271;563.490041512432;7182.138143422822;7437.888431673529;7450.552966822008;7475.8504829903095;7519.210482899217;539.2127493858932;548.5419674571698;560.6600225461151;568.8720037991502;573.4953241147847;3401.387750204937;3458.723302135823;3519.1026288296835;3540.398132317512;3629.256002519477;42349;43348.78325608415;50421.24368134481;52546.47453525492;53170;34803;39022.414663780066;47743.283850742264;53725.462745372824;55299;48593.5140648589;48795.512044879804;49431.25853112134;50080.49919500831;50734.492655073715;7986.840263194587;8293.543855088028;8464.957675211585;8614.138586141336;8725.956370218108;34984;35366.46950295799;35778.463323050695;36301.273974519834;36723;42897.571024289355;47969.520304796504;48095.79760506015;48337.516624833304;50172;9690;9982.251331150048;10119.848202277119;10246.282760207012;10596.099331556905;11137.10903127764;11384.943075284571;11667.533298667959;12327.69180770488;12337.198082124632;11529.596464123715;11549.88450115488;11848.229865058744;12430.875691242973;12431;10997.285176463503;11172.832407514057;11308.095352371625;11822;11826.940865295619;10484.842727359248;10935.945320273666;11548.48031838586;11907.166498345032;12059.21615095016;9623.711288661352;9699.66051188205;9974.40153590787;9981.151602113901;10082.798344033225;9771.48066777284;9856.507174641383;9934.503274836085;10008.899911000797;10019 15:05:55 INFO - PROCESS | 5011 | __end_tp_report 15:05:55 INFO - PROCESS | 5011 | __start_cc_report 15:05:55 INFO - PROCESS | 5011 | _x_x_mozilla_cycle_collect,2628 15:05:55 INFO - PROCESS | 5011 | __end_cc_report 15:05:55 INFO - PROCESS | 5011 | __startTimestamp1478819155042__endTimestamp 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | ------- Summary: start ------- 15:05:55 INFO - PROCESS | 5011 | Number of tests: 6 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#0] dojo.html Cycles:165 Average:4569.84 Median:4691.41 stddev:471.84 (10.1%) stddev-sans-first:446.77 15:05:55 INFO - PROCESS | 5011 | Values: 2581.5 2588.8 2597.8 2616.4 2651.7 4503.0 4579.0 4672.3 4682.7 4709.5 4619.7 4633.6 4640.0 4648.9 4649.6 4247.0 4270.3 4287.8 4309.9 4350.4 4329.7 4330.6 4335.0 4335.2 4349.5 4235.7 4259.7 4305.2 4305.6 4341.8 4360.0 4362.3 4362.9 4364.9 4370.2 4139.0 4164.3 4171.0 4277.8 4279.1 4582.7 4591.6 4595.5 4597.8 4622.1 4896.2 4903.1 4917.3 4918.1 4948.9 4788.3 4833.1 4835.1 4963.6 5005.4 4564.8 4575.9 4598.0 4620.4 4668.9 5041.3 5043.0 5043.7 5049.5 5094.7 4738.2 4823.0 4828.2 4841.8 4893.6 4882.6 4937.3 4959.5 4982.1 4983.7 4935.2 4945.4 4947.6 4979.3 4992.3 4884.2 4906.9 4908.6 4909.3 4955.9 4005.6 4019.7 4059.6 4071.9 4149.1 3580.0 3622.4 3645.7 3648.8 3649.9 4257.7 4279.5 4287.9 4298.6 4332.7 4834.7 4879.5 4946.6 4955.1 4995.8 4263.6 4270.5 4277.1 4281.9 4325.2 4469.8 4470.1 4503.3 4510.3 4511.7 4662.9 4671.4 4674.5 4680.5 4726.2 4820.0 4880.1 4887.6 4998.1 5004.9 4619.7 4658.6 4661.4 4662.9 4691.4 4888.7 4896.7 4899.1 4902.0 4956.1 4835.9 4917.1 4942.2 4971.5 5020.0 4764.6 4822.8 4823.3 4824.8 4826.5 4766.5 4790.7 4810.8 4814.3 4823.8 4715.4 4736.3 4740.3 4744.2 4749.3 4844.5 4845.6 4857.0 4859.1 4861.4 4715.9 4729.1 4749.5 4757.3 4762.5 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#1] ext.html Cycles:180 Average:44812.71 Median:192499.24 stddev:78454.57 (40.8%) stddev-sans-first:78604.26 15:05:55 INFO - PROCESS | 5011 | Values: 551.0 570.8 582.8 584.1 594.9 29468.0 38256.4 39267.0 39401.4 43405.3 38923.2 39179.0 39218.4 39271.2 39278.4 7238.5 7422.3 7565.2 7565.9 7568.2 7053.2 7273.1 7275.4 7283.7 9559.0 9581.5 9892.8 9899.1 9899.2 9903.1 9731.3 9790.4 9792.7 9797.3 9810.6 9663.0 9701.7 9735.6 9736.0 9738.4 36413.6 36886.4 36919.4 37061.8 37096.3 2943.5 2950.8 2980.0 2984.5 3280.8 26826.0 26834.6 26851.9 27625.0 28117.7 3456.2 3474.1 3480.4 3598.9 3647.8 237874.0 238164.0 238359.0 238394.0 239622.0 48879.0 49029.1 49046.3 49381.5 49386.0 30978.2 31852.5 31962.0 32523.8 32689.7 14601.5 14831.9 14858.9 14862.3 14868.6 11215.3 11359.0 11397.6 11399.8 11406.7 11531.7 11905.2 16602.7 16953.7 17331.3 6439.0 6520.6 6611.7 6677.7 6851.1 782.5 839.5 863.5 930.9 960.5 25839.9 26944.9 27135.1 27323.7 27484.3 913.4 957.7 999.4 1015.6 1015.8 14382.6 14537.6 14664.9 14675.3 14766.2 344405.0 348818.0 349578.0 349912.0 352097.0 45335.1 46570.0 47310.0 48426.0 48443.5 1169.7 1174.2 1187.1 1200.8 1212.1 26141.3 27333.6 27623.2 27921.0 28150.4 39469.4 45569.8 46989.5 51675.0 51936.0 297660.0 298930.0 300726.0 301325.0 301452.0 36348.0 36874.4 37029.8 37221.3 37535.2 39846.8 40492.6 40673.4 40776.8 41210.2 34660.7 34734.7 34753.1 34932.7 35129.6 34566.3 34870.8 34909.8 35086.5 35305.8 33705.0 34211.1 34685.3 34922.1 35276.3 29866.6 31470.5 31501.0 31548.0 31661.0 23246.8 24673.1 24872.9 25038.7 25050.5 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#2] jquery.html Cycles:180 Average:23127.14 Median:4505.61 stddev:61779.43 (1371.2%) stddev-sans-first:61928.95 15:05:55 INFO - PROCESS | 5011 | Values: 293.6 315.4 319.0 332.1 339.7 12382.1 15296.6 16031.7 16749.8 16991.6 15212.2 15693.1 15830.4 16649.5 16970.9 3611.3 4514.0 4672.2 4677.5 5195.5 5043.4 5122.9 5123.1 5123.8 5131.3 4866.6 5058.8 5083.7 5094.9 5102.9 4950.7 4977.2 4984.3 4985.2 4985.7 4347.4 4499.1 4512.2 4517.2 4518.9 10793.8 12153.8 12211.4 12221.4 12233.4 1821.8 1826.3 1886.1 1887.5 2035.8 8841.9 8848.4 9037.8 9257.5 11128.4 1634.1 1665.1 1720.5 1773.7 1783.0 58520.0 66553.0 66582.3 68455.0 69151.7 9168.7 9418.5 9420.9 9628.1 10044.8 10473.5 11181.6 12585.7 13603.5 13636.1 7292.9 7344.2 7369.5 7378.5 7499.7 6964.6 6970.2 7180.1 7186.9 7197.6 4023.5 4070.7 4122.6 4293.3 4320.8 1601.0 1668.7 1675.2 1684.3 1686.5 800.7 875.7 882.3 896.8 915.2 16235.8 16510.3 16649.2 16708.6 17330.6 816.0 855.8 859.8 860.5 867.1 8855.6 9588.6 9652.4 9659.8 9816.2 346982.1 359804.6 383669.0 386766.0 389454.0 72308.6 73870.1 74201.4 77571.0 78792.2 848.6 867.7 871.4 872.7 875.3 14698.7 14715.1 15078.7 15148.2 15283.6 35973.8 36130.3 36377.0 36884.8 37322.3 48769.0 48774.5 48923.0 49178.8 49229.5 7345.4 7361.9 7442.9 7499.1 7711.5 8395.0 10610.5 10815.2 12024.9 12065.8 10132.0 10147.6 10527.3 10769.4 10840.7 10345.2 10482.9 10557.5 10564.4 10621.3 10214.4 10469.5 10652.6 10662.0 11392.9 6330.8 6713.3 6743.8 6938.8 7779.7 4950.5 8192.0 9706.5 10283.2 10892.0 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#3] mootools.html Cycles:180 Average:4433.48 Median:5366.35 stddev:2408.05 (44.9%) stddev-sans-first:2402.40 15:05:55 INFO - PROCESS | 5011 | Values: 1182.2 1274.2 1322.8 1325.0 1626.9 5811.7 6416.5 6606.6 6609.7 6771.9 6672.0 6724.8 6730.5 6736.2 6741.2 2018.0 2038.6 2043.9 2045.8 2047.4 1973.3 2030.0 2045.4 2050.2 2052.4 1925.7 1945.6 1960.9 1965.4 1966.8 1926.1 1941.9 1943.9 1945.3 1945.9 1841.8 1868.0 1871.9 1881.7 1884.0 6650.0 6697.6 6707.2 6714.7 6725.2 4088.5 4292.1 4293.6 4294.5 4295.4 2564.4 2743.4 2802.5 2804.5 2806.9 815.1 840.1 845.5 860.0 872.4 8830.3 8938.1 8945.4 8983.5 8986.4 3494.7 3517.9 3581.9 3671.2 3686.5 7066.2 7070.6 7074.1 7078.0 7087.2 4099.5 4108.6 4110.4 4112.9 4113.8 3220.1 3333.6 3607.1 3744.6 3826.2 2869.0 2884.1 2963.9 2990.3 3005.1 843.3 867.7 875.8 882.0 882.5 690.5 695.6 707.6 809.0 846.7 4572.8 4812.2 4816.0 4845.8 5017.7 369.2 383.1 385.1 390.3 396.9 3286.3 3426.1 3430.4 3461.5 3566.0 7699.4 8181.8 8187.7 8198.7 8213.1 8123.0 8134.6 8138.5 8139.7 8146.6 6196.7 6302.8 6412.7 6416.8 6417.3 4736.3 4740.7 4792.0 4796.7 4840.0 7476.7 7484.5 7603.5 7608.1 7610.5 7638.2 7713.4 7726.4 7729.6 7764.5 5652.0 5708.4 5714.2 5714.9 5715.8 5721.5 5789.7 6564.8 6610.7 6718.6 5658.8 5751.5 5764.8 5793.3 5981.8 5868.7 6016.5 6038.8 6044.6 6114.8 5298.1 5434.6 5456.2 5581.4 5648.5 4160.4 4204.6 4229.0 4263.6 4268.3 4059.5 4090.7 4161.8 4179.6 4188.9 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#4] prototype.html Cycles:180 Average:4071.67 Median:4665.89 stddev:1191.39 (25.5%) stddev-sans-first:1160.13 15:05:55 INFO - PROCESS | 5011 | Values: 273.7 276.3 280.8 281.7 285.9 4752.7 4753.4 4757.2 4760.8 4767.8 4687.9 4701.9 4707.6 4719.8 4721.8 3459.3 3557.9 3559.3 3566.8 3689.3 3665.1 3678.2 3685.8 3691.0 3699.5 3638.1 3649.3 3654.7 3655.2 3661.5 3487.9 3569.6 3594.8 3674.2 3680.9 3193.9 3201.0 3209.4 3211.8 3245.5 4502.9 4505.3 4506.2 4517.4 4537.6 3969.6 4127.7 4129.6 4138.3 4145.3 4847.9 4862.2 4866.2 4869.5 4871.3 3531.6 3532.2 3534.2 3534.4 3536.2 4952.2 5087.0 5087.8 5095.8 5112.0 3570.6 3592.8 3592.9 3605.5 3618.0 3642.8 3648.0 3651.6 3661.4 3663.4 4151.1 4152.8 4158.1 4161.5 4174.2 4750.9 4836.3 4865.1 4910.4 4912.9 1220.1 1225.8 1227.5 1231.9 1236.8 810.3 822.8 837.4 838.0 848.4 4178.7 4254.3 4380.5 4384.7 4392.4 5044.1 5072.5 5076.4 5078.8 5082.3 4387.5 4399.9 4400.4 4408.5 4424.8 2480.0 2595.1 2599.4 2600.6 2622.4 4570.4 4597.7 4605.2 4621.5 4643.9 4928.4 4972.4 4983.7 5021.5 5031.4 4454.3 4769.9 4791.7 4808.8 4812.4 5109.4 5117.7 5125.3 5130.0 5147.8 4872.2 5013.6 5016.1 5029.3 5034.7 4738.4 4773.2 4810.9 4818.3 4824.8 3498.4 3506.9 3514.5 3517.6 3520.2 5102.5 5103.5 5111.7 5124.3 5144.1 4793.5 4886.6 4904.5 4924.5 4949.6 4883.3 4914.4 4919.6 4926.6 4936.9 4847.6 4864.5 4874.9 4876.6 4876.8 4779.7 4928.3 4982.4 4986.5 4990.2 4861.0 4863.6 4869.4 4872.1 4878.1 15:05:55 INFO - PROCESS | 5011 | 15:05:55 INFO - PROCESS | 5011 | [#5] yui.html Cycles:180 Average:13250.89 Median:23449.69 stddev:15503.86 (66.1%) stddev-sans-first:15518.43 15:05:55 INFO - PROCESS | 5011 | Values: 640.9 667.5 668.8 679.6 701.2 11931.3 12763.6 12769.6 12778.4 12779.7 11997.6 12043.2 12056.1 12130.9 12142.2 593.9 611.4 742.8 749.8 759.9 753.5 758.3 761.1 761.1 761.7 791.5 797.5 797.6 797.7 799.2 631.5 647.8 778.0 795.4 797.8 590.2 590.8 591.0 591.0 591.4 11933.6 11954.8 11964.0 11974.4 11974.9 11087.8 11300.9 11305.3 11385.3 11676.7 10479.3 10691.4 10722.6 10727.6 10795.0 3947.7 3957.8 3971.1 4021.4 4040.0 46440.8 47512.0 48074.5 48111.3 48442.5 8912.5 9026.0 9162.1 9235.0 9605.7 16166.9 16221.3 16267.6 16281.5 16370.5 6282.7 6324.3 6365.0 6396.0 6458.0 3380.8 3407.6 3451.8 3459.7 3469.7 2425.8 2494.9 2516.1 2520.0 2520.9 443.4 446.6 449.5 452.3 458.6 467.2 503.0 537.8 556.5 563.5 7182.1 7437.9 7450.6 7475.9 7519.2 539.2 548.5 560.7 568.9 573.5 3401.4 3458.7 3519.1 3540.4 3629.3 42349.0 43348.8 50421.2 52546.5 53170.0 34803.0 39022.4 47743.3 53725.5 55299.0 48593.5 48795.5 49431.3 50080.5 50734.5 7986.8 8293.5 8465.0 8614.1 8726.0 34984.0 35366.5 35778.5 36301.3 36723.0 42897.6 47969.5 48095.8 48337.5 50172.0 9690.0 9982.3 10119.8 10246.3 10596.1 11137.1 11384.9 11667.5 12327.7 12337.2 11529.6 11549.9 11848.2 12430.9 12431.0 10997.3 11172.8 11308.1 11822.0 11826.9 10484.8 10935.9 11548.5 11907.2 12059.2 9623.7 9699.7 9974.4 9981.2 10082.8 9771.5 9856.5 9934.5 10008.9 10019.0 15:05:55 INFO - PROCESS | 5011 | -------- Summary: end -------- 15:05:55 INFO - PROCESS | 5011 | 15:05:56 INFO - TEST-INFO | 5011: exit 0 15:05:56 INFO - TEST-OK | dromaeo_css | took 1123163ms 15:05:56 INFO - TEST-START | kraken 15:05:56 INFO - operating with platform_type : linux_ 15:05:56 INFO - Initialising browser for kraken test... 15:05:56 INFO - TEST-INFO | started process 5315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGLmhLu/profile http://localhost:54118/getInfo.html) 15:06:00 INFO - PROCESS | 5315 | __metrics Screen width/height:1600/1200 15:06:00 INFO - PROCESS | 5315 | colorDepth:24 15:06:00 INFO - PROCESS | 5315 | Browser inner width/height: 1024/697 15:06:00 INFO - PROCESS | 5315 | __metrics 15:06:01 INFO - PROCESS | 5315 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:06:01 INFO - PROCESS | 5315 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:02 INFO - TEST-INFO | 5315: exit 0 15:06:02 INFO - Browser initialized. 15:06:02 INFO - Running cycle 1/1 for kraken test... 15:06:02 INFO - TEST-INFO | started process 5394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGLmhLu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:14 INFO - PROCESS | 5394 | RSS: Main: 174649344 15:06:14 INFO - PROCESS | 5394 | 15:06:17 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54118/tests/kraken/driver.html?testName=audio-beat-detection) 15:06:18 INFO - PROCESS | 5394 | RSS: Main: 231149568 15:06:18 INFO - PROCESS | 5394 | 15:06:21 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54118/tests/kraken/driver.html?testName=audio-dft) 15:06:21 INFO - PROCESS | 5394 | RSS: Main: 217808896 15:06:21 INFO - PROCESS | 5394 | 15:06:25 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54118/tests/kraken/driver.html?testName=audio-fft) 15:06:25 INFO - PROCESS | 5394 | RSS: Main: 299388928 15:06:25 INFO - PROCESS | 5394 | 15:06:27 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54118/tests/kraken/driver.html?testName=audio-oscillator) 15:06:28 INFO - PROCESS | 5394 | RSS: Main: 210587648 15:06:28 INFO - PROCESS | 5394 | 15:06:30 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54118/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:06:31 INFO - PROCESS | 5394 | RSS: Main: 214249472 15:06:31 INFO - PROCESS | 5394 | 15:06:34 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54118/tests/kraken/driver.html?testName=imaging-darkroom) 15:06:35 INFO - PROCESS | 5394 | RSS: Main: 249454592 15:06:35 INFO - PROCESS | 5394 | 15:06:38 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54118/tests/kraken/driver.html?testName=imaging-desaturate) 15:06:39 INFO - PROCESS | 5394 | RSS: Main: 248983552 15:06:39 INFO - PROCESS | 5394 | 15:06:41 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54118/tests/kraken/driver.html?testName=json-parse-financial) 15:06:42 INFO - PROCESS | 5394 | RSS: Main: 247873536 15:06:42 INFO - PROCESS | 5394 | 15:06:44 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54118/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:06:44 INFO - PROCESS | 5394 | RSS: Main: 210358272 15:06:44 INFO - PROCESS | 5394 | 15:06:46 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:06:47 INFO - PROCESS | 5394 | RSS: Main: 217128960 15:06:47 INFO - PROCESS | 5394 | 15:06:49 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:06:50 INFO - PROCESS | 5394 | RSS: Main: 226451456 15:06:50 INFO - PROCESS | 5394 | 15:06:53 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:06:53 INFO - PROCESS | 5394 | RSS: Main: 235044864 15:06:53 INFO - PROCESS | 5394 | 15:06:56 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:06:57 INFO - PROCESS | 5394 | RSS: Main: 231788544 15:06:57 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | Cycle 1(1): loaded http://localhost:54118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54118/tests/kraken/driver.html?testName=ai-astar) 15:06:59 INFO - PROCESS | 5394 | RSS: Main: 281845760 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | __start_tp_report 15:06:59 INFO - PROCESS | 5394 | _x_x_mozilla_page_load 15:06:59 INFO - PROCESS | 5394 | _x_x_mozilla_page_load_details 15:06:59 INFO - PROCESS | 5394 | |i|pagename|runs| 15:06:59 INFO - PROCESS | 5394 | |0;ai-astar;111;119;118;118;117;117;116;116;116;118 15:06:59 INFO - PROCESS | 5394 | |1;audio-beat-detection;162;131;127;175;139;129;127;139;162;134 15:06:59 INFO - PROCESS | 5394 | |2;audio-dft;164;162;164;164;163;162;161;161;161;162 15:06:59 INFO - PROCESS | 5394 | |3;audio-fft;77;76;76;114;77;76;76;76;110;76 15:06:59 INFO - PROCESS | 5394 | |4;audio-oscillator;86;84;121;85;84;84;114;83;84;116 15:06:59 INFO - PROCESS | 5394 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 15:06:59 INFO - PROCESS | 5394 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;147;146 15:06:59 INFO - PROCESS | 5394 | |7;imaging-desaturate;85;86;85;85;85;85;86;86;85;85 15:06:59 INFO - PROCESS | 5394 | |8;json-parse-financial;64;63;65;63;63;65;65;63;64;65 15:06:59 INFO - PROCESS | 5394 | |9;json-stringify-tinderbox;67;66;66;66;68;66;68;67;66;66 15:06:59 INFO - PROCESS | 5394 | |10;stanford-crypto-aes;89;83;99;84;85;84;82;84;84;84 15:06:59 INFO - PROCESS | 5394 | |11;stanford-crypto-ccm;143;144;155;143;139;143;142;141;190;152 15:06:59 INFO - PROCESS | 5394 | |12;stanford-crypto-pbkdf2;182;178;179;185;179;185;184;183;181;191 15:06:59 INFO - PROCESS | 5394 | |13;stanford-crypto-sha256-iterative;70;69;73;68;69;69;68;67;68;68 15:06:59 INFO - PROCESS | 5394 | __end_tp_report 15:06:59 INFO - PROCESS | 5394 | __start_cc_report 15:06:59 INFO - PROCESS | 5394 | _x_x_mozilla_cycle_collect,1969 15:06:59 INFO - PROCESS | 5394 | __end_cc_report 15:06:59 INFO - PROCESS | 5394 | __startTimestamp1478819219560__endTimestamp 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | ------- Summary: start ------- 15:06:59 INFO - PROCESS | 5394 | Number of tests: 14 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.50 stddev:2.22 (1.9%) stddev-sans-first:1.09 15:06:59 INFO - PROCESS | 5394 | Values: 111.0 119.0 118.0 118.0 117.0 117.0 116.0 116.0 116.0 118.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:139.00 stddev:17.35 (12.5%) stddev-sans-first:16.90 15:06:59 INFO - PROCESS | 5394 | Values: 162.0 131.0 127.0 175.0 139.0 129.0 127.0 139.0 162.0 134.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.26 (0.8%) stddev-sans-first:1.20 15:06:59 INFO - PROCESS | 5394 | Values: 164.0 162.0 164.0 164.0 163.0 162.0 161.0 161.0 161.0 162.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.11 (19.9%) stddev-sans-first:15.85 15:06:59 INFO - PROCESS | 5394 | Values: 77.0 76.0 76.0 114.0 77.0 76.0 76.0 76.0 110.0 76.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:15.91 (18.9%) stddev-sans-first:16.61 15:06:59 INFO - PROCESS | 5394 | Values: 86.0 84.0 121.0 85.0 84.0 84.0 114.0 83.0 84.0 116.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:06:59 INFO - PROCESS | 5394 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 15:06:59 INFO - PROCESS | 5394 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 15:06:59 INFO - PROCESS | 5394 | Values: 85.0 86.0 85.0 85.0 85.0 85.0 86.0 86.0 85.0 85.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.50 stddev:0.94 (1.5%) stddev-sans-first:1.00 15:06:59 INFO - PROCESS | 5394 | Values: 64.0 63.0 65.0 63.0 63.0 65.0 65.0 63.0 64.0 65.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:06:59 INFO - PROCESS | 5394 | Values: 67.0 66.0 66.0 66.0 68.0 66.0 68.0 67.0 66.0 66.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.00 stddev:4.98 (5.9%) stddev-sans-first:5.15 15:06:59 INFO - PROCESS | 5394 | Values: 89.0 83.0 99.0 84.0 85.0 84.0 82.0 84.0 84.0 84.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:143.50 stddev:15.17 (10.6%) stddev-sans-first:15.93 15:06:59 INFO - PROCESS | 5394 | Values: 143.0 144.0 155.0 143.0 139.0 143.0 142.0 141.0 190.0 152.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:183.50 stddev:3.86 (2.1%) stddev-sans-first:4.09 15:06:59 INFO - PROCESS | 5394 | Values: 182.0 178.0 179.0 185.0 179.0 185.0 184.0 183.0 181.0 191.0 15:06:59 INFO - PROCESS | 5394 | 15:06:59 INFO - PROCESS | 5394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.72 15:06:59 INFO - PROCESS | 5394 | Values: 70.0 69.0 73.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 15:06:59 INFO - PROCESS | 5394 | -------- Summary: end -------- 15:06:59 INFO - PROCESS | 5394 | 15:07:00 INFO - TEST-INFO | 5394: exit 0 15:07:00 INFO - TEST-OK | kraken | took 64867ms 15:07:00 INFO - SUITE-END | took 1188s 15:07:01 INFO - Completed test suite (00:19:48) 15:07:01 INFO - javascript benchmark 15:07:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.5224183526047, 2588.805839562033, 2597.844129352239, 2616.3589920469462, 2651.7348265173487, 4503.0, 4579.038401935598, 4672.299155126732, 4682.719036857787, 4709.529047095289, 4619.653525985547, 4633.582977532022, 4639.953600463994, 4648.907021859561, 4649.6047835933905, 4247.044415006622, 4270.252705776492, 4287.7856107194675, 4309.913801723964, 4350.4344435223375, 4329.696921215516, 4330.588594083557, 4335.0, 4335.219660461115, 4349.456317960255, 4235.745855248695, 4259.70182087254, 4305.203537345586, 4305.634021108194, 4341.826326946934, 4360.040791025969, 4362.345648152771, 4362.934555981663, 4364.912701745948, 4370.2352088384405, 4138.979305103485, 4164.250434921712, 4171.040660648037, 4277.8288868445225, 4279.144171165779, 4582.679212455096, 4591.586757191869, 4595.471520775087, 4597.781135676768, 4622.098690755271, 4896.192128298826, 4903.092927808367, 4917.262410638397, 4918.114739346916, 4948.901021979576, 4788.257820037899, 4833.130036593447, 4835.1296766582, 4963.627727920384, 5005.449400565934, 4564.817407303737, 4575.93136102952, 4598.034412773288, 4620.422447194101, 4668.85993420198, 5041.319421878073, 5043.041822053798, 5043.722595257223, 5049.545540901337, 5094.745262736848, 4738.218193998021, 4823.03539292143, 4828.155072862235, 4841.806327746921, 4893.584045356185, 4882.609391248691, 4937.308776771255, 4959.479254678206, 4982.103221420107, 4983.6760610560195, 4935.210366341368, 4945.357103576512, 4947.6289278304275, 4979.253112033224, 4992.2511623256805, 4884.1941079722155, 4906.90186196274, 4908.558229759267, 4909.337239472697, 4955.925661115086, 4005.599440055971, 4019.738716983387, 4059.6346328829954, 4071.941295263253, 4149.128682976549, 3580.0, 3622.4385220290897, 3645.65366290202, 3648.7628304160144, 3649.908752281214, 4257.723247988871, 4279.529251782302, 4287.935680964788, 4298.591633794785, 4332.718373305725, 4834.661573689878, 4879.463259041502, 4946.604271658331, 4955.083309587738, 4995.750212489361, 4263.637590804754, 4270.530241673413, 4277.101808620225, 4281.935770963376, 4325.15659446405, 4469.7988590513505, 4470.1059788041875, 4503.347014682852, 4510.323451482304, 4511.684182107221, 4662.906741865144, 4671.392718946515, 4674.5091765365505, 4680.531946805292, 4726.19654658702, 4820.0, 4880.097182021195, 4887.584555312838, 4998.075356059141, 5004.924926126038, 4619.69971951822, 4658.627309815274, 4661.440627124767, 4662.883427914329, 4691.413573303337, 4888.7311197884455, 4896.6572339935865, 4899.1426500363, 4901.950980490149, 4956.083124621957, 4835.927461088157, 4917.139500587455, 4942.20924652054, 4971.453140154653, 5020.046191223656, 4764.618830493621, 4822.831200907952, 4823.252395878644, 4824.758762061953, 4826.517348265145, 4766.547178018082, 4790.7365094920115, 4810.783514741775, 4814.253790662453, 4823.782929768098, 4715.434147902273, 4736.313234581035, 4740.312654665123, 4744.1697702901165, 4749.311349854321, 4844.539768721966, 4845.563899249085, 4857.028594281087, 4859.1010663027455, 4861.440934292602, 4715.905681886412, 4729.054189162112, 4749.525047495223, 4757.286407038971, 4762.547557981986], "value": 4540.064312682392, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9504144626983, 570.8230448560946, 582.8222392170389, 584.0567483514126, 594.9048152295634, 29468.0, 38256.42615360768, 39266.99999999996, 39401.40897886527, 43405.34891976623, 38923.221535569275, 39179.0, 39218.411723824094, 39271.21457570854, 39278.41082383759, 7238.529495582797, 7422.257774222575, 7565.243475652445, 7565.886511702329, 7568.205338439468, 7053.224145344008, 7273.054502914641, 7275.381592564612, 7283.672234749449, 9558.952205238964, 9581.473018983954, 9892.752681182956, 9899.059589339036, 9899.15857152143, 9903.10872021518, 9731.318807683465, 9790.363626364298, 9792.657256996043, 9797.31418800677, 9810.558524866326, 9663.0, 9701.70894873155, 9735.610575576968, 9736.0, 9738.367006144577, 36413.63586364155, 36886.44670329947, 36919.446208306894, 37061.81469092664, 37096.258074838624, 2943.499605067144, 2950.822950622948, 2979.970200297991, 2984.5373967035143, 3280.7867488613165, 26826.0, 26834.5974810378, 26851.86574067117, 27625.0, 28117.718822811716, 3456.2050728332374, 3474.1314671332166, 3480.443129099357, 3598.874039408608, 3647.8176091195332, 237874.0, 238164.0, 238359.0, 238394.0, 239622.0, 48879.02241955141, 49029.116506019505, 49046.26430603544, 49381.506184937694, 49386.0, 30978.225544361572, 31852.522212166838, 31962.0, 32523.837380812944, 32689.673103268662, 14601.488947886774, 14831.851681483264, 14858.851411485746, 14862.331195096247, 14868.628284292763, 11215.271007384494, 11359.0, 11397.601083962187, 11399.772004559862, 11406.714832129263, 11531.711707207387, 11905.226160299553, 16602.683302341236, 16953.745693814602, 17331.30674772995, 6439.034144878306, 6520.576162549419, 6611.669416529155, 6677.732890684415, 6851.07510486088, 782.4679218131612, 839.5298632765671, 863.5034854958424, 930.8557173637962, 960.4772557792692, 25839.870800645876, 26944.865275673495, 27135.10767069641, 27323.726762732516, 27484.312892177855, 913.3880300198882, 957.6648173139346, 999.3654029691053, 1015.6343716262139, 1015.8476228565627, 14382.568522944328, 14537.563873083824, 14664.926675366554, 14675.266236688123, 14766.187859667607, 344405.0, 348818.0, 349578.0, 349912.0, 352097.0, 45335.14651254614, 46570.0, 47310.0, 48426.0, 48443.51556484461, 1169.6958790714305, 1174.17220859294, 1187.0978056676815, 1200.8378868852767, 1212.1393810394718, 26141.346466338495, 27333.589996150473, 27623.171304860887, 27921.0, 28150.43699126047, 39469.40795888122, 45569.772151139034, 46989.53010469989, 51675.0, 51936.0, 297660.0, 298930.0, 300726.0, 301325.0, 301452.0, 36348.0, 36874.44688329624, 37029.814850926654, 37221.25557488781, 37535.249295014495, 39846.800765995984, 40492.595074048884, 40673.38989915213, 40776.796116020414, 41210.1757964833, 34660.65339346574, 34734.65265347314, 34753.13117172091, 34932.65067349294, 35129.64870351264, 34566.30867382688, 34870.825645871606, 34909.82545087258, 35086.47370289499, 35305.764298249436, 33705.0, 34211.14472138217, 34685.306293874484, 34922.12694682653, 35276.29447410986, 29866.552001720425, 31470.52794208043, 31501.0, 31548.0, 31661.0, 23246.76753232446, 24673.136440224505, 24872.875635621705, 25038.74961250364, 25050.498990020464], "value": 17316.202709286277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.58897543439195, 315.37581455504136, 319.0268191237198, 332.0917291208545, 339.66373290442453, 12382.133250672445, 15296.617584560392, 16031.67936641268, 16749.83250167498, 16991.57521061974, 15212.163331016789, 15693.136877471734, 15830.445934392299, 16649.50051498454, 16970.915145424286, 3611.3319035978298, 4513.977430112853, 4672.205725026736, 4677.4620918594455, 5195.532402083812, 5043.445221025684, 5122.897542049157, 5123.129068058421, 5123.846284611449, 5131.307273518083, 4866.635002374818, 5058.822941197059, 5083.703655567843, 5094.9045955119645, 5102.872428189288, 4950.727709975949, 4977.15388383972, 4984.3021976923255, 4985.227289770091, 4985.675931064469, 4347.413099231627, 4499.055198408339, 4512.165249428866, 4517.164324599959, 4518.932216016729, 10793.83809242862, 12153.817692734616, 12211.389430528438, 12221.388930553525, 12233.449494772756, 1821.817818218181, 1826.3151318255655, 1886.1135266424758, 1887.5186827359073, 2035.847311451647, 8841.911580884173, 8848.380613357067, 9037.774055648595, 9257.490838003907, 11128.38793866337, 1634.1012443156335, 1665.1341302522742, 1720.4666553368495, 1773.689604319239, 1782.9956523258352, 58520.0, 66553.0, 66582.3341766581, 68455.0, 69151.65424172897, 9168.679096231599, 9418.529073546433, 9420.858687119699, 9628.085331893599, 10044.849327260097, 10473.528691208761, 11181.608643697431, 12585.685357866127, 13603.455861765418, 13636.113652612548, 7292.868223221038, 7344.228855970153, 7369.520981136209, 7378.483506154517, 7499.662515186829, 6964.582125072512, 6970.233274339818, 7180.138383394026, 7186.92813071873, 7197.604131772698, 4023.5372932112596, 4070.6946978976694, 4122.587741225853, 4293.291606884892, 4320.848770293024, 1600.9679806403806, 1668.7163182259046, 1675.1875340459867, 1684.2505085237196, 1686.5446329491215, 800.7437619961556, 875.6584931876573, 882.3117967984982, 896.7533928169805, 915.1809130827871, 16235.756463653055, 16510.33958641665, 16649.16754162287, 16708.58228544296, 17330.566735831453, 816.0452270843009, 855.8117214212863, 859.7635650196121, 860.4708104515678, 867.0808942520948, 8855.557222138867, 9588.616455341848, 9652.420854748738, 9659.758506037264, 9816.165625921876, 346982.1337519099, 359804.6029309562, 383669.0, 386766.0, 389454.0, 72308.63845680738, 73870.1355837303, 74201.38576442018, 77571.0, 78792.24227152023, 848.5841937450729, 867.6616119713191, 871.3813192633302, 872.6814712629845, 875.282268539804, 14698.706025879637, 14715.117092974457, 15078.698426031637, 15148.242587870784, 15283.636670790329, 35973.82013089918, 36130.27739445144, 36377.0, 36884.81557592195, 37322.253554929295, 48769.0, 48774.512254876994, 48923.0, 49178.75410622924, 49229.507704923926, 7345.375643070399, 7361.852762944604, 7442.92557074444, 7499.100107987077, 7711.537307761552, 8395.0, 10610.514527966245, 10815.172727902796, 12024.939875300568, 12065.758684826429, 10132.0, 10147.594096236067, 10527.315724477885, 10769.407682577534, 10840.67477975662, 10345.224108191765, 10482.947585262025, 10557.472126393495, 10564.366138031743, 10621.256512044392, 10214.387136771817, 10469.476526173508, 10652.57389704403, 10662.0, 11392.886071139183, 6330.841728956629, 6713.295104014008, 6743.763968261087, 6938.791836244921, 7779.72770953014, 4950.529699678525, 8191.959040204761, 9706.5146742664, 10283.200439923134, 10891.98498277821], "value": 7731.617682844572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.2256422043565, 1274.2227241382755, 1322.8015797630355, 1324.9735005299895, 1626.9023858568487, 5811.680357580337, 6416.518761092919, 6606.636634985074, 6609.7025633846415, 6771.932280677192, 6672.0, 6724.764633237838, 6730.528862979593, 6736.191657001166, 6741.157355330583, 2017.9697304540443, 2038.6432374334431, 2043.8671486353414, 2045.826104781088, 2047.4062521868714, 1973.289615738333, 2030.0255877178963, 2045.3557129504234, 2050.159434631801, 2052.384284714587, 1925.711143328505, 1945.5525229197292, 1960.892150931698, 1965.439849642852, 1966.8426525877896, 1926.0562324460984, 1941.932032378874, 1943.8542109341856, 1945.251078334837, 1945.9416217513497, 1841.815818418161, 1867.953301167468, 1871.9251229950785, 1881.698928171486, 1884.0, 6650.0, 6697.564658297195, 6707.195136583641, 6714.731410743564, 6725.159355080615, 4088.509378874554, 4292.1415716856445, 4293.592108749695, 4294.527601963813, 4295.377170310318, 2564.4230048239183, 2743.396452780385, 2802.5095608268675, 2804.5372513535244, 2806.8736906839035, 815.1481701621819, 840.0633293877344, 845.5096044294295, 860.036758830108, 872.4111224923151, 8830.293576513928, 8938.106189381075, 8945.418547794372, 8983.505907175102, 8986.41588296765, 3494.6910793412003, 3517.8592856285463, 3581.8746343877838, 3671.155634204148, 3686.5391826021746, 7066.222715501291, 7070.646467676595, 7074.080369552028, 7078.0444639973975, 7087.220405755363, 4099.487564054493, 4108.568600296986, 4110.424540564323, 4112.938305925413, 4113.814878330482, 3220.0983724557163, 3333.599968003855, 3607.0801945504254, 3744.588095309514, 3826.1773718650625, 2869.0, 2884.1059271625863, 2963.866626001835, 2990.2673844908136, 3005.113491520007, 843.325339728215, 867.7223288547731, 875.7810547363159, 881.9823603527893, 882.5057967538199, 690.4993879437368, 695.5861262548775, 707.5648476187108, 809.0, 846.7121178799115, 4572.81708731647, 4812.181929072066, 4815.975920120377, 4845.781939812717, 5017.724025178651, 369.1951545630551, 383.1360282562803, 385.0777388155352, 390.3111009068995, 396.869033219037, 3286.342731453719, 3426.1434641339665, 3430.4168291390524, 3461.5153878457036, 3566.0, 7699.422543309274, 8181.836363272821, 8187.672493100328, 8198.672053117809, 8213.055498617736, 8122.959385203036, 8134.593270336578, 8138.511689298661, 8139.715109971123, 8146.592670366458, 6196.721147548371, 6302.842428939313, 6412.711427985845, 6416.7754128605275, 6417.326180751047, 4736.336912832275, 4740.691855029412, 4791.952080479151, 4796.688215265996, 4839.95160048395, 7476.663550140365, 7484.476086673881, 7603.46775725716, 7608.087029556488, 7610.467267291458, 7638.197989211275, 7713.382929365525, 7726.42051846125, 7729.613519324123, 7764.456488045783, 5652.039153343859, 5708.372079071216, 5714.228579141929, 5714.857128571819, 5715.771369145187, 5721.456461636138, 5789.652620842763, 6564.770233041821, 6610.70251838678, 6718.596884186964, 5658.801941932177, 5751.4536119068625, 5764.827055188351, 5793.275840519935, 5981.790637327673, 5868.677222752619, 6016.458518733335, 6038.818835434944, 6044.576879618385, 6114.785982490592, 5298.072837253389, 5434.619576629598, 5456.154296084113, 5581.441855814386, 5648.548116150616, 4160.355144952538, 4204.600562946515, 4228.9788551057045, 4263.616274535307, 4268.2530557152995, 4059.4722686050623, 4090.7114259008317, 4161.791910404529, 4179.6029377209115, 4188.91622167561], "value": 3549.5763114965057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.6825282672101, 276.3133612971766, 280.8208303564341, 281.65369533629257, 285.9056511351253, 4752.714837109772, 4753.382060332161, 4757.238841785315, 4760.8097975506125, 4767.761611919404, 4687.88280292992, 4701.929471057937, 4707.62339012879, 4719.764011799413, 4721.834735784249, 3459.3427248822645, 3557.861484325017, 3559.3059353426092, 3566.7681600696, 3689.262147570497, 3665.083729067733, 3678.209185025219, 3685.778853268799, 3690.9630903691022, 3699.5190625218684, 3638.108663377476, 3649.2701459708032, 3654.7441679082476, 3655.1593133579295, 3661.4507823826507, 3487.8953631390973, 3569.625189355132, 3594.8202589870534, 3674.228412033476, 3680.871169509081, 3193.8562764675644, 3200.983995080033, 3209.3581283743347, 3211.807291562514, 3245.496947973068, 4502.93245601313, 4505.346724724929, 4506.188886000518, 4517.40249356618, 4537.636989040901, 3969.6030396960364, 4127.711060225785, 4129.587041295877, 4138.296489596745, 4145.274576949022, 4847.927281090751, 4862.17343051682, 4866.197077482211, 4869.537393947605, 4871.318015477836, 3531.593866705336, 3532.205253817896, 3534.2224710563637, 3534.3638145133864, 3536.1513236823234, 4952.182889823211, 5087.0, 5087.79648814047, 5095.821646242363, 5111.974440127776, 3570.6429357064603, 3592.7844329340323, 3592.892213233607, 3605.531280933514, 3617.981910090433, 3642.817859107034, 3647.9817600911824, 3651.561812582454, 3661.41417373219, 3663.432168013962, 4151.12826306473, 4152.750834949852, 4158.126793373365, 4161.459010328638, 4174.248635245624, 4750.904981900343, 4836.250381190921, 4865.148598995162, 4910.386201724785, 4912.852614421573, 1220.1032241302635, 1225.7629825568374, 1227.5089964014467, 1231.8644949055597, 1236.8268442418068, 810.295043312322, 822.7572866004543, 837.4347315562093, 837.9832403351899, 848.3510114762212, 4178.749275043447, 4254.298040823292, 4380.474343078851, 4384.7369157850635, 4392.363107349416, 5044.066847633199, 5072.51811077947, 5076.416212135578, 5078.771455284521, 5082.263071854561, 4387.5393083726385, 4399.912001759947, 4400.437844565134, 4408.4930233023615, 4424.75663838492, 2479.9752002480104, 2595.091717898758, 2599.4281258123183, 2600.609908513738, 2622.41343986889, 4570.360149579062, 4597.747123908217, 4605.217113090783, 4621.468531118964, 4643.907121857544, 4928.383952005999, 4972.353594032753, 4983.6760610560195, 5021.472745361758, 5031.371078615173, 4454.287314029804, 4769.9046019080115, 4791.736454495036, 4808.773762690562, 4812.35033270504, 5109.437961824122, 5117.718525481134, 5125.283599692169, 5129.9743501282255, 5147.794088236428, 4872.244802055687, 5013.598912087097, 5016.147254966738, 5029.346184995927, 5034.672746271481, 4738.431388233434, 4773.164696178224, 4810.855674329776, 4818.277258411266, 4824.782884770124, 3498.422760244633, 3506.8772592959126, 3514.4728290756593, 3517.577890653138, 3520.1903562181355, 5102.464241254764, 5103.540681338697, 5111.718855462986, 5124.282600435868, 5144.116192274809, 4793.5446132618745, 4886.560209581155, 4904.460509343898, 4924.532169443897, 4949.554540091409, 4883.267509873547, 4914.36113305268, 4919.631027672867, 4926.630502712239, 4936.901261974812, 4847.61219102478, 4864.489228630943, 4874.878128046827, 4876.609871210224, 4876.78054487556, 4779.657967595923, 4928.349003083864, 4982.377202849644, 4986.501349864984, 4990.176620857663, 4860.9513904861915, 4863.562279394871, 4869.391326084239, 4872.052408292931, 4878.0975519529], "value": 3688.6690222919433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9455196308313, 667.5360624366065, 668.7793028300658, 679.6465837764359, 701.1551080947457, 11931.343776092323, 12763.617091487247, 12769.553065642704, 12778.424970876298, 12779.680507987305, 11997.640070797868, 12043.156979011474, 12056.095792815551, 12130.93934530326, 12142.150049496538, 593.9249957576778, 611.3672349118663, 742.7771668499455, 749.763824395315, 759.9050118735158, 753.4951582439751, 758.260695821575, 761.0828951113895, 761.0828951113922, 761.6686741267539, 791.5329955326356, 797.4776521378477, 797.5732982854174, 797.6689673785401, 799.1648727080216, 631.5421319543341, 647.805658302512, 778.0468925566192, 795.3637090327744, 797.8045378882211, 590.1619700025973, 590.8020813027598, 590.9970450147765, 591.03956071384, 591.3583761618648, 11933.641990740292, 11954.820677689842, 11964.04287656994, 11974.401279935968, 11974.940125299318, 11087.778244435147, 11300.943495282554, 11305.321680699102, 11385.259958102697, 11676.708082297926, 10479.318844275174, 10691.358518488838, 10722.571097156104, 10727.624533141381, 10795.0, 3947.695273298145, 3957.762534247954, 3971.0667993021616, 4021.416894550303, 4039.9900024993754, 46440.76779616114, 47512.0, 48074.519254807354, 48111.278330825415, 48442.515574844154, 8912.465252084767, 9026.0, 9162.123643322047, 9234.984151743303, 9605.663801767045, 16166.919165404097, 16221.2700428481, 16267.593310167103, 16281.51155465338, 16370.508884733477, 6282.654454005074, 6324.33594472583, 6365.013422919455, 6396.0, 6457.999010153434, 3380.8478618462227, 3407.591089069278, 3451.7928924264625, 3459.723222142273, 3469.7050750686476, 2425.8180636451984, 2494.9376265593505, 2516.0564788204424, 2520.0, 2520.899164033455, 443.4191209515545, 446.5869071109211, 449.5324862143334, 452.27861560810453, 458.6216371493531, 467.1731036066144, 502.97485125743566, 537.8278950735805, 556.5158312268271, 563.490041512432, 7182.138143422822, 7437.888431673529, 7450.552966822008, 7475.8504829903095, 7519.210482899217, 539.2127493858932, 548.5419674571698, 560.6600225461151, 568.8720037991502, 573.4953241147847, 3401.387750204937, 3458.723302135823, 3519.1026288296835, 3540.398132317512, 3629.256002519477, 42349.0, 43348.78325608415, 50421.24368134481, 52546.47453525492, 53170.0, 34803.0, 39022.414663780066, 47743.283850742264, 53725.462745372824, 55299.0, 48593.5140648589, 48795.512044879804, 49431.25853112134, 50080.49919500831, 50734.492655073715, 7986.840263194587, 8293.543855088028, 8464.957675211585, 8614.138586141336, 8725.956370218108, 34984.0, 35366.46950295799, 35778.463323050695, 36301.273974519834, 36723.0, 42897.571024289355, 47969.520304796504, 48095.79760506015, 48337.516624833304, 50172.0, 9690.0, 9982.251331150048, 10119.848202277119, 10246.282760207012, 10596.099331556905, 11137.10903127764, 11384.943075284571, 11667.533298667959, 12327.69180770488, 12337.198082124632, 11529.596464123715, 11549.88450115488, 11848.229865058744, 12430.875691242973, 12431.0, 10997.285176463503, 11172.832407514057, 11308.095352371625, 11822.0, 11826.940865295619, 10484.842727359248, 10935.945320273666, 11548.48031838586, 11907.166498345032, 12059.21615095016, 9623.711288661352, 9699.66051188205, 9974.40153590787, 9981.151602113901, 10082.798344033225, 9771.48066777284, 9856.507174641383, 9934.503274836085, 10008.899911000797, 10019.0], "value": 5849.822134576978, "unit": "score"}], "name": "dromaeo_css", "value": 5997.981391145528, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 119.0, 118.0, 118.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 127.0, 175.0, 139.0, 129.0, 127.0, 139.0, 162.0, 134.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 164.0, 163.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 114.0, 77.0, 76.0, 76.0, 76.0, 110.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 121.0, 85.0, 84.0, 84.0, 114.0, 83.0, 84.0, 116.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 63.0, 65.0, 65.0, 63.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 66.0, 68.0, 67.0, 66.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 99.0, 84.0, 85.0, 84.0, 82.0, 84.0, 84.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 155.0, 143.0, 139.0, 143.0, 142.0, 141.0, 190.0, 152.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 178.0, 179.0, 185.0, 179.0, 185.0, 184.0, 183.0, 181.0, 191.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1564.6, "alertThreshold": 2.0}]} 15:07:01 INFO - Return code: 0 15:07:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:01 INFO - # TBPL SUCCESS # 15:07:01 INFO - Running post-action listener: _resource_record_post_action 15:07:01 INFO - [mozharness: 2016-11-10 23:07:01.357417Z] Finished run-tests step (success) 15:07:01 INFO - Running post-run listener: _resource_record_post_run 15:07:01 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 389242880; Read time: 0; Write time: 351800 15:07:01 INFO - TinderboxPrint: CPU usage
13.1% 15:07:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:07:01 INFO - TinderboxPrint: I/O write bytes / time
389,242,880 / 351,800 15:07:01 INFO - TinderboxPrint: CPU idle
8,351.9 (86.9%) 15:07:01 INFO - TinderboxPrint: CPU user
1,205.8 (12.6%) 15:07:01 INFO - TinderboxPrint: Swap in / out
0 / 0 15:07:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99717120; Read time: 0; Write time: 101988 15:07:01 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289525760; Read time: 0; Write time: 249812 15:07:01 INFO - Running post-run listener: _upload_blobber_files 15:07:01 INFO - Blob upload gear active. 15:07:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:01 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 15:07:01 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'] 15:07:01 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 15:07:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:05 INFO - (blobuploader) - INFO - Done attempting. 15:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:06 INFO - (blobuploader) - INFO - Done attempting. 15:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:07 INFO - (blobuploader) - INFO - Done attempting. 15:07:07 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:07 INFO - Return code: 0 15:07:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a226e5d810ff4d9a27e6d5da13c1a44556dad095397b0d7e26bdf97aaf0a63cfdd551a0543f37ef7c2279d1770b60fc1eb9cb703863dbfe6dcff06e09cc107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30390df3817a1c367c7ce315dc1cc6314c3f53195384cb71bbfe1a545036df16f08321ed4993f51d44960c9fee0970fd6c6b32931de9c445f077e4120a62e95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c3b03cf9ab20995bbbd29d856f3121c2f0e288dc568f16973a99aad0433d635f02b21d33b85bd15bb4888aac747bde2c9adee2e2e812741e12faef06861bb7"} 15:07:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:07 INFO - Contents: 15:07:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a226e5d810ff4d9a27e6d5da13c1a44556dad095397b0d7e26bdf97aaf0a63cfdd551a0543f37ef7c2279d1770b60fc1eb9cb703863dbfe6dcff06e09cc107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30390df3817a1c367c7ce315dc1cc6314c3f53195384cb71bbfe1a545036df16f08321ed4993f51d44960c9fee0970fd6c6b32931de9c445f077e4120a62e95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c3b03cf9ab20995bbbd29d856f3121c2f0e288dc568f16973a99aad0433d635f02b21d33b85bd15bb4888aac747bde2c9adee2e2e812741e12faef06861bb7"} 15:07:07 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:07 INFO - Copying logs to upload dir... 15:07:07 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.242660 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-10 15:07:07.332134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 15:07:07.335499) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a226e5d810ff4d9a27e6d5da13c1a44556dad095397b0d7e26bdf97aaf0a63cfdd551a0543f37ef7c2279d1770b60fc1eb9cb703863dbfe6dcff06e09cc107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30390df3817a1c367c7ce315dc1cc6314c3f53195384cb71bbfe1a545036df16f08321ed4993f51d44960c9fee0970fd6c6b32931de9c445f077e4120a62e95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c3b03cf9ab20995bbbd29d856f3121c2f0e288dc568f16973a99aad0433d635f02b21d33b85bd15bb4888aac747bde2c9adee2e2e812741e12faef06861bb7"} build_url:https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/SgS0u9gsRda6sYFW3OjfqQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a226e5d810ff4d9a27e6d5da13c1a44556dad095397b0d7e26bdf97aaf0a63cfdd551a0543f37ef7c2279d1770b60fc1eb9cb703863dbfe6dcff06e09cc107", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30390df3817a1c367c7ce315dc1cc6314c3f53195384cb71bbfe1a545036df16f08321ed4993f51d44960c9fee0970fd6c6b32931de9c445f077e4120a62e95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57c3b03cf9ab20995bbbd29d856f3121c2f0e288dc568f16973a99aad0433d635f02b21d33b85bd15bb4888aac747bde2c9adee2e2e812741e12faef06861bb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 15:07:07.360531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:07:07.360849) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478816994.919832-1600572495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:07:07.445325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 15:07:07.445663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 15:07:07.445990) ========= ========= Total master_lag: 0.19 =========