builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1476159413.02 results: success (0) buildid: 20161010193002 builduid: c593939cf8e2433e822c10c442a941f9 revision: 723c2e894079d0c870a1b78679f971c7a1d3d31f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.024936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.025371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.025663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.043098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.043359) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 21:16:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-10-10 21:16:54 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.147469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.147771) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.197156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:53.197549) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 723c2e894079d0c870a1b78679f971c7a1d3d31f --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 723c2e894079d0c870a1b78679f971c7a1d3d31f --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=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 21:16:54,558 truncating revision to first 12 chars 2016-10-10 21:16:54,558 Setting DEBUG logging. 2016-10-10 21:16:54,558 attempt 1/10 2016-10-10 21:16:54,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/723c2e894079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 21:16:54,995 unpacking tar archive at: mozilla-central-723c2e894079/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:54.010866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:54.011163) ========= script_repo_revision: 723c2e894079d0c870a1b78679f971c7a1d3d31f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:54.011552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:54.011828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:16:54.020786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-10 21:16:54.021110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:16:55 INFO - MultiFileLogger online at 20161010 21:16:55 in /builds/slave/test 21:16:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:16:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:16:55 INFO - {'append_to_log': False, 21:16:55 INFO - 'base_work_dir': '/builds/slave/test', 21:16:55 INFO - 'blob_upload_branch': 'Firefox', 21:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:16:55 INFO - 'branch': 'Firefox', 21:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 21:16:55 INFO - 'config_files': ('talos/linux_config.py',), 21:16:55 INFO - 'default_actions': ('clobber', 21:16:55 INFO - 'read-buildbot-config', 21:16:55 INFO - 'download-and-extract', 21:16:55 INFO - 'populate-webroot', 21:16:55 INFO - 'create-virtualenv', 21:16:55 INFO - 'install', 21:16:55 INFO - 'run-tests'), 21:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:16:55 INFO - 'download_minidump_stackwalk': True, 21:16:55 INFO - 'download_symbols': 'ondemand', 21:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 21:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 21:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:16:55 INFO - 'installer_path': 'installer.exe', 21:16:55 INFO - 'log_level': 'info', 21:16:55 INFO - 'log_name': 'talos', 21:16:55 INFO - 'log_to_console': True, 21:16:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:16:55 INFO - 'opt_config_files': (), 21:16:55 INFO - 'pip_index': False, 21:16:55 INFO - 'sps_profile': False, 21:16:55 INFO - 'sps_profile_interval': 0, 21:16:55 INFO - 'suite': 'dromaeojs', 21:16:55 INFO - 'system_bits': '32', 21:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:16:55 INFO - 'title': 'talos-linux64-ix-012', 21:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:16:55 INFO - 'use_talos_json': True, 21:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:16:55 INFO - 'work_dir': 'build'} 21:16:55 INFO - [mozharness: 2016-10-11 04:16:55.488303Z] Running clobber step. 21:16:55 INFO - Running pre-action listener: _resource_record_pre_action 21:16:55 INFO - Running main action method: clobber 21:16:55 INFO - rmtree: /builds/slave/test/build 21:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:16:55 INFO - Running post-action listener: _resource_record_post_action 21:16:55 INFO - [mozharness: 2016-10-11 04:16:55.947781Z] Finished clobber step (success) 21:16:55 INFO - [mozharness: 2016-10-11 04:16:55.947881Z] Running read-buildbot-config step. 21:16:55 INFO - Running pre-action listener: _resource_record_pre_action 21:16:55 INFO - Running main action method: read_buildbot_config 21:16:55 INFO - Using buildbot properties: 21:16:55 INFO - { 21:16:55 INFO - "project": "", 21:16:55 INFO - "product": "firefox", 21:16:55 INFO - "script_repo_revision": "production", 21:16:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:16:55 INFO - "repository": "", 21:16:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:16:55 INFO - "buildid": "20161010193002", 21:16:55 INFO - "pgo_build": "True", 21:16:55 INFO - "basedir": "/builds/slave/test", 21:16:55 INFO - "buildnumber": 590, 21:16:55 INFO - "slavename": "talos-linux64-ix-012", 21:16:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:16:55 INFO - "platform": "ubuntu64_hw", 21:16:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:16:55 INFO - "branch": "mozilla-central", 21:16:55 INFO - "repo_path": "mozilla-central", 21:16:55 INFO - "revision": "723c2e894079d0c870a1b78679f971c7a1d3d31f", 21:16:55 INFO - "stage_platform": "linux64-pgo", 21:16:55 INFO - "builduid": "c593939cf8e2433e822c10c442a941f9", 21:16:55 INFO - "slavebuilddir": "test" 21:16:55 INFO - } 21:16:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:16:55 INFO - Running post-action listener: _resource_record_post_action 21:16:55 INFO - [mozharness: 2016-10-11 04:16:55.950320Z] Finished read-buildbot-config step (success) 21:16:55 INFO - [mozharness: 2016-10-11 04:16:55.950408Z] Running download-and-extract step. 21:16:55 INFO - Running pre-action listener: _resource_record_pre_action 21:16:55 INFO - Running main action method: download_and_extract 21:16:55 INFO - mkdir: /builds/slave/test/build/tests 21:16: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')]} 21:16:55 INFO - trying https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:16:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/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 21:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/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 21:16:56 INFO - Downloaded 1361 bytes. 21:16:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:16:56 INFO - Using the following test package requirements: 21:16:56 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:16:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:16:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:16:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'jsshell-linux-x86_64.zip'], 21:16:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:16:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:16:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:16:56 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:16:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:16:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:16:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:16:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:16:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:16:56 INFO - Fetch https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:16:57 INFO - Http code: 200 21:16:57 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 21:16:57 INFO - x-amz-cf-id: oGYdjQJ8Kn_TSuN4b4dGWuieL4sOs34_LiOzE66ZzPREjzBcpNnOFg== 21:16:57 INFO - x-amz-version-id: OYGySZ2q9Jxc694XBUUVQvSe7yVlYTiI 21:16:57 INFO - Expected file size: 22100047 21:16:57 INFO - Obtained file size: 22100047 21:17:01 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 21:17:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:17:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:17:01 INFO - Fetch https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:17:01 INFO - Http code: 200 21:17:01 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 21:17:01 INFO - x-amz-cf-id: VdLnsSgXD4davnH39tktxQ93SORnQbVUuw-jhhVZ5ij_vrv_cN7RrQ== 21:17:01 INFO - x-amz-version-id: OYGySZ2q9Jxc694XBUUVQvSe7yVlYTiI 21:17:02 INFO - Expected file size: 22100047 21:17:02 INFO - Obtained file size: 22100047 21:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:17:07 INFO - Http code: 200 21:17:07 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 21:17:07 INFO - x-amz-cf-id: 9O2d_DAQ1e-DCcVGwC_wb6BpBIQ-9hjVJDhMPFAN_xjoRoQgAgjNBw== 21:17:07 INFO - x-amz-version-id: uBC3HA06LIvX8oVDCPhHpUoR2a3PHIwn 21:17:07 INFO - Expected file size: 14409006 21:17:07 INFO - Obtained file size: 14409006 21:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:07 INFO - trying https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:17:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/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 21:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/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 21:17:08 INFO - Downloaded 59713892 bytes. 21:17:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:17:08 INFO - mkdir: /builds/slave/test/properties 21:17:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:17:08 INFO - Writing to file /builds/slave/test/properties/build_url 21:17:08 INFO - Contents: 21:17:08 INFO - build_url:https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:17:09 INFO - Running post-action listener: _resource_record_post_action 21:17:09 INFO - Running post-action listener: set_extra_try_arguments 21:17:09 INFO - [mozharness: 2016-10-11 04:17:09.512769Z] Finished download-and-extract step (success) 21:17:09 INFO - [mozharness: 2016-10-11 04:17:09.513065Z] Running populate-webroot step. 21:17:09 INFO - Running pre-action listener: _resource_record_pre_action 21:17:09 INFO - Running main action method: populate_webroot 21:17:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:17:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:17:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:17:09 INFO - '--tppagecycles', 21:17:09 INFO - '7'], 21:17:09 INFO - 'tests': ['tsvgm']}}, 21:17:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:17:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:17:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:17:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:17:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['damp', 'tps']}, 21:17:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'tests': ['damp', 'tps']}, 21:17:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['dromaeo_dom']}, 21:17:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:17:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['basic_compositor_video']}, 21:17:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:17:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'other-e10s': {'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['a11yr', 21:17:09 INFO - 'ts_paint', 21:17:09 INFO - 'tpaint', 21:17:09 INFO - 'sessionrestore', 21:17:09 INFO - 'sessionrestore_no_auto_restore', 21:17:09 INFO - 'tabpaint']}, 21:17:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['tsvgx', 21:17:09 INFO - 'tsvgr_opacity', 21:17:09 INFO - 'tart', 21:17:09 INFO - 'tscrollx', 21:17:09 INFO - 'cart']}, 21:17:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:17:09 INFO - 'tsvgr_opacity', 21:17:09 INFO - 'tart', 21:17:09 INFO - 'tscrollx', 21:17:09 INFO - 'cart']}, 21:17:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'talos_options': ['--disable-e10s'], 21:17:09 INFO - 'tests': ['tp5o']}, 21:17:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'tests': ['tp5o']}, 21:17:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'talos_options': ['--disable-e10s', 21:17:09 INFO - '--xperf_path', 21:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:09 INFO - 'tests': ['tp5n']}, 21:17:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:09 INFO - 'talos_options': ['--xperf_path', 21:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:09 INFO - 'tests': ['tp5n']}}, 21:17:09 INFO - 'talos.zip': {'path': '', 21:17:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:17:09 INFO - Running post-action listener: _resource_record_post_action 21:17:09 INFO - [mozharness: 2016-10-11 04:17:09.535588Z] Finished populate-webroot step (success) 21:17:09 INFO - [mozharness: 2016-10-11 04:17:09.535681Z] Running create-virtualenv step. 21:17:09 INFO - Running pre-action listener: _resource_record_pre_action 21:17:09 INFO - Running main action method: create_virtualenv 21:17:09 INFO - Creating virtualenv /builds/slave/test/build/venv 21:17:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:17:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:17:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:17:09 INFO - Using real prefix '/usr' 21:17:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:17:10 INFO - Installing distribute.............................................................................................................................................................................................done. 21:17:12 INFO - Installing pip.................done. 21:17:12 INFO - Return code: 0 21:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:17:12 INFO - Reading from file tmpfile_stdout 21:17:12 INFO - Output received: 21:17:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:17:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:17: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')]} 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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')]} 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:17:12 INFO - Using env: {'DISPLAY': ':0', 21:17:12 INFO - 'HOME': '/home/cltbld', 21:17:12 INFO - 'LANG': 'en_US.UTF-8', 21:17:12 INFO - 'LANGUAGE': 'en_US:en', 21:17:12 INFO - 'LOGNAME': 'cltbld', 21:17:12 INFO - 'MAIL': '/var/mail/cltbld', 21:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:12 INFO - 'MOZ_NO_REMOTE': '1', 21:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:12 INFO - 'NO_EM_RESTART': '1', 21:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:12 INFO - 'PWD': '/builds/slave/test', 21:17:12 INFO - 'SHELL': '/bin/bash', 21:17:12 INFO - 'SHLVL': '1', 21:17:12 INFO - 'TERM': 'linux', 21:17:12 INFO - 'TMOUT': '86400', 21:17:12 INFO - 'USER': 'cltbld', 21:17:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:12 INFO - '_': '/tools/buildbot/bin/python'} 21:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:17:12 INFO - Cleaning up... 21:17:12 INFO - Return code: 0 21:17:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:17: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')]} 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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')]} 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:12 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:17:12 INFO - Using env: {'DISPLAY': ':0', 21:17:12 INFO - 'HOME': '/home/cltbld', 21:17:12 INFO - 'LANG': 'en_US.UTF-8', 21:17:12 INFO - 'LANGUAGE': 'en_US:en', 21:17:12 INFO - 'LOGNAME': 'cltbld', 21:17:12 INFO - 'MAIL': '/var/mail/cltbld', 21:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:12 INFO - 'MOZ_NO_REMOTE': '1', 21:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:12 INFO - 'NO_EM_RESTART': '1', 21:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:12 INFO - 'PWD': '/builds/slave/test', 21:17:12 INFO - 'SHELL': '/bin/bash', 21:17:12 INFO - 'SHLVL': '1', 21:17:12 INFO - 'TERM': 'linux', 21:17:12 INFO - 'TMOUT': '86400', 21:17:12 INFO - 'USER': 'cltbld', 21:17:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:12 INFO - '_': '/tools/buildbot/bin/python'} 21:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:12 INFO - Downloading/unpacking psutil>=3.1.1 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:14 INFO - Installing collected packages: psutil 21:17:14 INFO - Running setup.py install for psutil 21:17:14 INFO - building 'psutil._psutil_linux' extension 21:17:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:17:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:17:15 INFO - building 'psutil._psutil_posix' extension 21:17:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:17:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:15 INFO - Successfully installed psutil 21:17:15 INFO - Cleaning up... 21:17:15 INFO - Return code: 0 21:17:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:17:15 INFO - Using env: {'DISPLAY': ':0', 21:17:15 INFO - 'HOME': '/home/cltbld', 21:17:15 INFO - 'LANG': 'en_US.UTF-8', 21:17:15 INFO - 'LANGUAGE': 'en_US:en', 21:17:15 INFO - 'LOGNAME': 'cltbld', 21:17:15 INFO - 'MAIL': '/var/mail/cltbld', 21:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:15 INFO - 'MOZ_NO_REMOTE': '1', 21:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:15 INFO - 'NO_EM_RESTART': '1', 21:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:15 INFO - 'PWD': '/builds/slave/test', 21:17:15 INFO - 'SHELL': '/bin/bash', 21:17:15 INFO - 'SHLVL': '1', 21:17:15 INFO - 'TERM': 'linux', 21:17:15 INFO - 'TMOUT': '86400', 21:17:15 INFO - 'USER': 'cltbld', 21:17:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:15 INFO - '_': '/tools/buildbot/bin/python'} 21:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:17:17 INFO - Installing collected packages: mozsystemmonitor 21:17:17 INFO - Running setup.py install for mozsystemmonitor 21:17:17 INFO - Successfully installed mozsystemmonitor 21:17:17 INFO - Cleaning up... 21:17:17 INFO - Return code: 0 21:17:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:17 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:17:17 INFO - Using env: {'DISPLAY': ':0', 21:17:17 INFO - 'HOME': '/home/cltbld', 21:17:17 INFO - 'LANG': 'en_US.UTF-8', 21:17:17 INFO - 'LANGUAGE': 'en_US:en', 21:17:17 INFO - 'LOGNAME': 'cltbld', 21:17:17 INFO - 'MAIL': '/var/mail/cltbld', 21:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:17 INFO - 'MOZ_NO_REMOTE': '1', 21:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:17 INFO - 'NO_EM_RESTART': '1', 21:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:17 INFO - 'PWD': '/builds/slave/test', 21:17:17 INFO - 'SHELL': '/bin/bash', 21:17:17 INFO - 'SHLVL': '1', 21:17:17 INFO - 'TERM': 'linux', 21:17:17 INFO - 'TMOUT': '86400', 21:17:17 INFO - 'USER': 'cltbld', 21:17:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:17 INFO - '_': '/tools/buildbot/bin/python'} 21:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:17 INFO - Downloading/unpacking jsonschema==2.5.1 21:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:17:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:19 INFO - Downloading functools32-3.2.3-2.tar.gz 21:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:17:20 INFO - warning: no files found matching '*.txt' 21:17:20 INFO - no previously-included directories found matching 'build' 21:17:20 INFO - no previously-included directories found matching 'dist' 21:17:20 INFO - no previously-included directories found matching '.git*' 21:17:20 INFO - Installing collected packages: jsonschema, functools32 21:17:20 INFO - Running setup.py install for functools32 21:17:20 INFO - warning: no files found matching '*.txt' 21:17:20 INFO - no previously-included directories found matching 'build' 21:17:20 INFO - no previously-included directories found matching 'dist' 21:17:20 INFO - no previously-included directories found matching '.git*' 21:17:20 INFO - Successfully installed jsonschema functools32 21:17:20 INFO - Cleaning up... 21:17:20 INFO - Return code: 0 21:17:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:17: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')]} 21:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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')]} 21:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:17:20 INFO - Using env: {'DISPLAY': ':0', 21:17:20 INFO - 'HOME': '/home/cltbld', 21:17:20 INFO - 'LANG': 'en_US.UTF-8', 21:17:20 INFO - 'LANGUAGE': 'en_US:en', 21:17:20 INFO - 'LOGNAME': 'cltbld', 21:17:20 INFO - 'MAIL': '/var/mail/cltbld', 21:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:20 INFO - 'MOZ_NO_REMOTE': '1', 21:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:20 INFO - 'NO_EM_RESTART': '1', 21:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:20 INFO - 'PWD': '/builds/slave/test', 21:17:20 INFO - 'SHELL': '/bin/bash', 21:17:20 INFO - 'SHLVL': '1', 21:17:20 INFO - 'TERM': 'linux', 21:17:20 INFO - 'TMOUT': '86400', 21:17:20 INFO - 'USER': 'cltbld', 21:17:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:20 INFO - '_': '/tools/buildbot/bin/python'} 21:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:17:20 INFO - Cleaning up... 21:17:20 INFO - Return code: 0 21:17:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:17: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')]} 21:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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')]} 21:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:17:20 INFO - Using env: {'DISPLAY': ':0', 21:17:20 INFO - 'HOME': '/home/cltbld', 21:17:20 INFO - 'LANG': 'en_US.UTF-8', 21:17:20 INFO - 'LANGUAGE': 'en_US:en', 21:17:20 INFO - 'LOGNAME': 'cltbld', 21:17:20 INFO - 'MAIL': '/var/mail/cltbld', 21:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:20 INFO - 'MOZ_NO_REMOTE': '1', 21:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:20 INFO - 'NO_EM_RESTART': '1', 21:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:20 INFO - 'PWD': '/builds/slave/test', 21:17:20 INFO - 'SHELL': '/bin/bash', 21:17:20 INFO - 'SHLVL': '1', 21:17:20 INFO - 'TERM': 'linux', 21:17:20 INFO - 'TMOUT': '86400', 21:17:20 INFO - 'USER': 'cltbld', 21:17:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:20 INFO - '_': '/tools/buildbot/bin/python'} 21:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:20 INFO - Downloading/unpacking blobuploader==1.2.4 21:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 21:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:17:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:23 INFO - Downloading docopt-0.6.1.tar.gz 21:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 21:17:23 INFO - Running setup.py install for blobuploader 21:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:17:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:17:23 INFO - Running setup.py install for requests 21:17:23 INFO - Running setup.py install for docopt 21:17:23 INFO - Successfully installed blobuploader requests docopt 21:17:23 INFO - Cleaning up... 21:17:24 INFO - Return code: 0 21:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:24 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:17:24 INFO - Using env: {'DISPLAY': ':0', 21:17:24 INFO - 'HOME': '/home/cltbld', 21:17:24 INFO - 'LANG': 'en_US.UTF-8', 21:17:24 INFO - 'LANGUAGE': 'en_US:en', 21:17:24 INFO - 'LOGNAME': 'cltbld', 21:17:24 INFO - 'MAIL': '/var/mail/cltbld', 21:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:24 INFO - 'MOZ_NO_REMOTE': '1', 21:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:24 INFO - 'NO_EM_RESTART': '1', 21:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:24 INFO - 'PWD': '/builds/slave/test', 21:17:24 INFO - 'SHELL': '/bin/bash', 21:17:24 INFO - 'SHLVL': '1', 21:17:24 INFO - 'TERM': 'linux', 21:17:24 INFO - 'TMOUT': '86400', 21:17:24 INFO - 'USER': 'cltbld', 21:17:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:24 INFO - '_': '/tools/buildbot/bin/python'} 21:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:24 INFO - Running setup.py (path:/tmp/pip-yXDL33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:24 INFO - Running setup.py (path:/tmp/pip-PlMSsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:24 INFO - Running setup.py (path:/tmp/pip-niDTln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:24 INFO - Running setup.py (path:/tmp/pip-E_vma7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:24 INFO - Running setup.py (path:/tmp/pip-fYl2dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:24 INFO - Running setup.py (path:/tmp/pip-gV4njy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:24 INFO - Running setup.py (path:/tmp/pip-wCekhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:24 INFO - Running setup.py (path:/tmp/pip-EfGMo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:24 INFO - Running setup.py (path:/tmp/pip-NitfH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:24 INFO - Running setup.py (path:/tmp/pip-eLfD5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:24 INFO - Running setup.py (path:/tmp/pip-2ff0jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:25 INFO - Running setup.py (path:/tmp/pip-7EsvzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:25 INFO - Running setup.py (path:/tmp/pip-8y0D7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:25 INFO - Running setup.py (path:/tmp/pip-QLgGOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:25 INFO - Running setup.py (path:/tmp/pip-thkgnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:25 INFO - Running setup.py (path:/tmp/pip-pVUoeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:25 INFO - Running setup.py (path:/tmp/pip-NML4yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:17:25 INFO - Running setup.py install for manifestparser 21:17:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:17:25 INFO - Running setup.py install for mozcrash 21:17:25 INFO - Running setup.py install for mozdebug 21:17:25 INFO - Running setup.py install for mozdevice 21:17:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:17:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:17:25 INFO - Running setup.py install for mozfile 21:17:25 INFO - Running setup.py install for mozhttpd 21:17:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozinfo 21:17:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozInstall 21:17:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozleak 21:17:26 INFO - Running setup.py install for mozlog 21:17:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for moznetwork 21:17:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozprocess 21:17:26 INFO - Running setup.py install for mozprofile 21:17:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozrunner 21:17:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:17:26 INFO - Running setup.py install for mozscreenshot 21:17:27 INFO - Running setup.py install for moztest 21:17:27 INFO - Running setup.py install for mozversion 21:17:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:17:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:17:27 INFO - Cleaning up... 21:17:27 INFO - Return code: 0 21:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:27 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:17:27 INFO - Using env: {'DISPLAY': ':0', 21:17:27 INFO - 'HOME': '/home/cltbld', 21:17:27 INFO - 'LANG': 'en_US.UTF-8', 21:17:27 INFO - 'LANGUAGE': 'en_US:en', 21:17:27 INFO - 'LOGNAME': 'cltbld', 21:17:27 INFO - 'MAIL': '/var/mail/cltbld', 21:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:27 INFO - 'MOZ_NO_REMOTE': '1', 21:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:27 INFO - 'NO_EM_RESTART': '1', 21:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:27 INFO - 'PWD': '/builds/slave/test', 21:17:27 INFO - 'SHELL': '/bin/bash', 21:17:27 INFO - 'SHLVL': '1', 21:17:27 INFO - 'TERM': 'linux', 21:17:27 INFO - 'TMOUT': '86400', 21:17:27 INFO - 'USER': 'cltbld', 21:17:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:27 INFO - '_': '/tools/buildbot/bin/python'} 21:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:27 INFO - Running setup.py (path:/tmp/pip-2QvANR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:27 INFO - Running setup.py (path:/tmp/pip-I4zNNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:27 INFO - Running setup.py (path:/tmp/pip-dLsu7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:27 INFO - Running setup.py (path:/tmp/pip-6B_pUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:27 INFO - Running setup.py (path:/tmp/pip-CpdAvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:27 INFO - Running setup.py (path:/tmp/pip-DIlqCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:27 INFO - Running setup.py (path:/tmp/pip-zV559e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:27 INFO - Running setup.py (path:/tmp/pip-Dx_FOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:28 INFO - Running setup.py (path:/tmp/pip-HA6KNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:28 INFO - Running setup.py (path:/tmp/pip-lJztrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:28 INFO - Running setup.py (path:/tmp/pip-aYWEto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:28 INFO - Running setup.py (path:/tmp/pip-kTQ23_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:28 INFO - Running setup.py (path:/tmp/pip-I0g6Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:28 INFO - Running setup.py (path:/tmp/pip-6dvAeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:28 INFO - Running setup.py (path:/tmp/pip-qw5pD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:28 INFO - Running setup.py (path:/tmp/pip-Pj69Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:28 INFO - Running setup.py (path:/tmp/pip-UvpkjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:30 INFO - Downloading blessings-1.6.tar.gz 21:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:17:30 INFO - Installing collected packages: blessings 21:17:30 INFO - Running setup.py install for blessings 21:17:30 INFO - Successfully installed blessings 21:17:30 INFO - Cleaning up... 21:17:30 INFO - Return code: 0 21:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:31 INFO - Reading from file tmpfile_stdout 21:17:31 INFO - Current package versions: 21:17:31 INFO - argparse == 1.2.1 21:17:31 INFO - blessings == 1.6 21:17:31 INFO - blobuploader == 1.2.4 21:17:31 INFO - docopt == 0.6.1 21:17:31 INFO - functools32 == 3.2.3-2 21:17:31 INFO - jsonschema == 2.5.1 21:17:31 INFO - manifestparser == 1.1 21:17:31 INFO - mozInstall == 1.12 21:17:31 INFO - mozcrash == 0.17 21:17:31 INFO - mozdebug == 0.1 21:17:31 INFO - mozdevice == 0.48 21:17:31 INFO - mozfile == 1.2 21:17:31 INFO - mozhttpd == 0.7 21:17:31 INFO - mozinfo == 0.9 21:17:31 INFO - mozleak == 0.1 21:17:31 INFO - mozlog == 3.4 21:17:31 INFO - moznetwork == 0.27 21:17:31 INFO - mozprocess == 0.23 21:17:31 INFO - mozprofile == 0.28 21:17:31 INFO - mozrunner == 6.12 21:17:31 INFO - mozscreenshot == 0.1 21:17:31 INFO - mozsystemmonitor == 0.3 21:17:31 INFO - moztest == 0.7 21:17:31 INFO - mozversion == 1.4 21:17:31 INFO - psutil == 3.1.1 21:17:31 INFO - requests == 1.2.3 21:17:31 INFO - wsgiref == 0.1.2 21:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:31 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:17:31 INFO - Using env: {'DISPLAY': ':0', 21:17:31 INFO - 'HOME': '/home/cltbld', 21:17:31 INFO - 'LANG': 'en_US.UTF-8', 21:17:31 INFO - 'LANGUAGE': 'en_US:en', 21:17:31 INFO - 'LOGNAME': 'cltbld', 21:17:31 INFO - 'MAIL': '/var/mail/cltbld', 21:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:31 INFO - 'MOZ_NO_REMOTE': '1', 21:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:31 INFO - 'NO_EM_RESTART': '1', 21:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:31 INFO - 'PWD': '/builds/slave/test', 21:17:31 INFO - 'SHELL': '/bin/bash', 21:17:31 INFO - 'SHLVL': '1', 21:17:31 INFO - 'TERM': 'linux', 21:17:31 INFO - 'TMOUT': '86400', 21:17:31 INFO - 'USER': 'cltbld', 21:17:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:31 INFO - '_': '/tools/buildbot/bin/python'} 21:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:17:31 INFO - Cleaning up... 21:17:31 INFO - Return code: 0 21:17:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:31 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 0x7f2913ebcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:17:31 INFO - Using env: {'DISPLAY': ':0', 21:17:31 INFO - 'HOME': '/home/cltbld', 21:17:31 INFO - 'LANG': 'en_US.UTF-8', 21:17:31 INFO - 'LANGUAGE': 'en_US:en', 21:17:31 INFO - 'LOGNAME': 'cltbld', 21:17:31 INFO - 'MAIL': '/var/mail/cltbld', 21:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:31 INFO - 'MOZ_NO_REMOTE': '1', 21:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:31 INFO - 'NO_EM_RESTART': '1', 21:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:31 INFO - 'PWD': '/builds/slave/test', 21:17:31 INFO - 'SHELL': '/bin/bash', 21:17:31 INFO - 'SHLVL': '1', 21:17:31 INFO - 'TERM': 'linux', 21:17:31 INFO - 'TMOUT': '86400', 21:17:31 INFO - 'USER': 'cltbld', 21:17:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:31 INFO - '_': '/tools/buildbot/bin/python'} 21:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:17:31 INFO - Cleaning up... 21:17:31 INFO - Return code: 0 21:17:31 INFO - Running post-action listener: _resource_record_post_action 21:17:31 INFO - Running post-action listener: _start_resource_monitoring 21:17:31 INFO - Starting resource monitoring. 21:17:31 INFO - [mozharness: 2016-10-11 04:17:31.634623Z] Finished create-virtualenv step (success) 21:17:31 INFO - [mozharness: 2016-10-11 04:17:31.635141Z] Running install step. 21:17:31 INFO - Running pre-action listener: _resource_record_pre_action 21:17:31 INFO - Running main action method: install 21:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:31 INFO - Reading from file tmpfile_stdout 21:17:31 INFO - Detecting whether we're running mozinstall >=1.0... 21:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:17:31 INFO - Reading from file tmpfile_stdout 21:17:31 INFO - Output received: 21:17:31 INFO - Usage: mozinstall [options] installer 21:17:31 INFO - Options: 21:17:31 INFO - -h, --help show this help message and exit 21:17:31 INFO - -d DEST, --destination=DEST 21:17:31 INFO - Directory to install application into. [default: 21:17:31 INFO - "/builds/slave/test"] 21:17:31 INFO - --app=APP Application being installed. [default: firefox] 21:17:31 INFO - mkdir: /builds/slave/test/build/application 21:17:31 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'] 21:17:31 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 21:17:49 INFO - Reading from file tmpfile_stdout 21:17:49 INFO - Output received: 21:17:49 INFO - /builds/slave/test/build/application/firefox/firefox 21:17:49 INFO - Running post-action listener: _resource_record_post_action 21:17:49 INFO - [mozharness: 2016-10-11 04:17:49.026068Z] Finished install step (success) 21:17:49 INFO - [mozharness: 2016-10-11 04:17:49.026315Z] Running run-tests step. 21:17:49 INFO - Running pre-action listener: _resource_record_pre_action 21:17:49 INFO - Running main action method: run_tests 21:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:17:49 INFO - Python 2.7.3 21:17:49 INFO - Return code: 0 21:17:49 INFO - grabbing minidump binary from tooltool 21:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:49 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 0x23a5930>, '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 0x23a6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a6cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:17:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:17:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:17:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:17:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:17:49 INFO - Return code: 0 21:17:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:17:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:17:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:17:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:17:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 21:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 21:17:49 INFO - Using env: {'DISPLAY': ':0', 21:17:49 INFO - 'HOME': '/home/cltbld', 21:17:49 INFO - 'LANG': 'en_US.UTF-8', 21:17:49 INFO - 'LANGUAGE': 'en_US:en', 21:17:49 INFO - 'LOGNAME': 'cltbld', 21:17:49 INFO - 'MAIL': '/var/mail/cltbld', 21:17:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:17:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:49 INFO - 'MOZ_NO_REMOTE': '1', 21:17:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:49 INFO - 'NO_EM_RESTART': '1', 21:17:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:49 INFO - 'PWD': '/builds/slave/test', 21:17:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:17:49 INFO - 'SHELL': '/bin/bash', 21:17:49 INFO - 'SHLVL': '1', 21:17:49 INFO - 'TERM': 'linux', 21:17:49 INFO - 'TMOUT': '86400', 21:17:49 INFO - 'USER': 'cltbld', 21:17:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723', 21:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:49 INFO - '_': '/tools/buildbot/bin/python'} 21:17:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 21:17:49 INFO - mozversion application_buildid: 20161010193002 21:17:49 INFO - mozversion application_changeset: 723c2e894079d0c870a1b78679f971c7a1d3d31f 21:17:49 INFO - mozversion application_display_name: Nightly 21:17:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:17:49 INFO - mozversion application_name: Firefox 21:17:49 INFO - mozversion application_remotingname: firefox 21:17:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:17:49 INFO - mozversion application_vendor: Mozilla 21:17:49 INFO - mozversion application_version: 52.0a1 21:17:49 INFO - mozversion platform_buildid: 20161010193002 21:17:49 INFO - mozversion platform_changeset: 723c2e894079d0c870a1b78679f971c7a1d3d31f 21:17:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:17:49 INFO - mozversion platform_version: 52.0a1 21:17:49 INFO - using testdate: 1476159469 21:17:49 INFO - actual date: 1476159469 21:17:49 INFO - starting webserver on 'localhost:51270' 21:17:49 INFO - SUITE-START | Running 2 tests 21:17:49 INFO - TEST-START | dromaeo_css 21:17:49 INFO - operating with platform_type : linux_ 21:17:49 INFO - Initialising browser for dromaeo_css test... 21:17:49 INFO - TEST-INFO | started process 28105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0CaQB0/profile http://localhost:51270/getInfo.html) 21:17:53 INFO - PROCESS | 28105 | __metrics Screen width/height:1600/1200 21:17:53 INFO - PROCESS | 28105 | colorDepth:24 21:17:53 INFO - PROCESS | 28105 | Browser inner width/height: 1024/697 21:17:53 INFO - PROCESS | 28105 | __metrics 21:17:53 INFO - PROCESS | 28105 | 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" 21:17:53 INFO - PROCESS | 28105 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:17:54 INFO - PROCESS | 28105 | console.error: PushService: 21:17:54 INFO - PROCESS | 28105 | stateChangeProcessEnqueue: Error transitioning state 21:17:54 INFO - PROCESS | 28105 | UnknownError 21:17:54 INFO - TEST-INFO | 28105: exit 0 21:17:54 INFO - Browser initialized. 21:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:17:54 INFO - TEST-INFO | started process 28189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0CaQB0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:06 INFO - PROCESS | 28189 | RSS: Main: 172638208 21:18:06 INFO - PROCESS | 28189 | 21:18:58 INFO - PROCESS | 28189 | 1476159538153 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:21:08 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51270/tests/dromaeo/cssquery-ext.html) 21:21:09 INFO - PROCESS | 28189 | RSS: Main: 310874112 21:21:09 INFO - PROCESS | 28189 | 21:24:11 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-ext.html (next: http://localhost:51270/tests/dromaeo/cssquery-jquery.html) 21:24:12 INFO - PROCESS | 28189 | RSS: Main: 263983104 21:24:12 INFO - PROCESS | 28189 | 21:27:14 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51270/tests/dromaeo/cssquery-mootools.html) 21:27:15 INFO - PROCESS | 28189 | RSS: Main: 214228992 21:27:15 INFO - PROCESS | 28189 | 21:30:17 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51270/tests/dromaeo/cssquery-prototype.html) 21:30:17 INFO - PROCESS | 28189 | RSS: Main: 244834304 21:30:17 INFO - PROCESS | 28189 | 21:33:20 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51270/tests/dromaeo/cssquery-yui.html) 21:33:21 INFO - PROCESS | 28189 | RSS: Main: 213639168 21:33:21 INFO - PROCESS | 28189 | 21:36:23 INFO - PROCESS | 28189 | Cycle 1(1): loaded http://localhost:51270/tests/dromaeo/cssquery-yui.html (next: http://localhost:51270/tests/dromaeo/cssquery-dojo.html) 21:36:24 INFO - PROCESS | 28189 | RSS: Main: 304889856 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | __start_tp_report 21:36:24 INFO - PROCESS | 28189 | _x_x_mozilla_page_load 21:36:24 INFO - PROCESS | 28189 | _x_x_mozilla_page_load_details 21:36:24 INFO - PROCESS | 28189 | |i|pagename|runs| 21:36:24 INFO - PROCESS | 28189 | |0;dojo.html;2918.985405072974;2961.096865456035;2966.3622321200946;2996.8501574921247;3015.788894777365;4976.203807390818;5030.069437154129;5034.270030845525;5103.668261563001;5161.674270977976;5102.285680004802;5102.387713474379;5121.078205922932;5155.793768249266;5226.817061402851;4608.792604332796;4621.491635920046;4635.559621835937;4643.442786865581;4693.9530604693855;4661.813527458898;4701.811927522895;4705.458872229686;4725.858224253261;4751.691140075901;4504.6396288296855;4558.133954548658;4564.931526027112;4595.356650068993;4596.3794887690065;4507.16617425774;4524.140413321491;4525.932111018337;4564.931526027112;4594.471635761864;4495.64034877209;4498.010437703732;4502.279635258343;4518.118966801475;4549.454065512126;4894.2658601210105;4928.67963582366;4982.651214414992;4987.326710894019;4987.351644286256;5384.5692344612335;5409.9459005409835;5434.592405569598;5451.3458384993655;5504;5487.6158668893195;5488.506034456918;5500.092484740013;5505.834824955217;5505.862353441156;4939.431965324034;5144.614153938394;5144.6141539384325;5151.17581187012;5212.478752124757;5363.517283444508;5534.916976245359;5595.63628364155;5598.384177740445;5672.4894759471845;5371.167469042305;5377.085895397791;5379.085555455582;5382.434844341366;5382.973085134549;5437.510624043855;5452.591055670761;5454.290942177491;5458.317710286215;5520.199571062173;5162.174052151638;5255.054090263713;5257.369115706139;5365.034293827149;5419.078756611386;5429.267048948342;5447.346318441733;5471.206675032098;5499.202615620713;5504.80733174337;4235.639970602471;4235.745855248633;4237.5762423758;4286.61420472159;4287.871363859089;3774.735768496234;3789.03379638196;3816.866409675648;3819.1406933440308;3843.673287770515;5094.337736094284;5167.354080739908;5170.250313704491;5236.685798852005;5241.50205730455;5459.2629994950175;5461.535769459561;5462.590305727007;5463.48096930791;5518.503334699816;5112.769925353368;5114.616403769658;5119.667221630582;5119.897602047939;5178.896422071537;4647.07058588277;4670.416197975253;4677.298405239241;4681.8361357353015;4759.595434388047;5552.5557955362665;5557.41647127054;5562.137868630369;5610.747516361774;5620.185073164368;5363.329583802025;5366.195070739421;5370.543503802221;5373.143243996642;5373.543248823894;5483.4516548344845;5531.612787104864;5560.499555040065;5594.104943209067;5621.971890140523;5370.2213179089595;5381.085215513451;5381.973090134525;5443.591730620298;5445.482679145475;5331.840044798662;5391.379991301051;5451.454854514517;5461.972690136524;5464.945350546603;5119.488051195;5174.482551744795;5223.45153758865;5281.519672188508;5286.577073834007;5183.585313175013;5226.529612334908;5231.503007214308;5257.080010997984;5308.548773354154;5217.921731173959;5223.52988231061;5232.659877107976;5233.319668443078;5287.101192797157;5232.921506177487;5304.60215483848;5304.681719096867;5310.707911064928;5317.441668624739;5169.043726910533;5188;5203.167493201221;5245.475452454724;5248.6325957182635 21:36:24 INFO - PROCESS | 28189 | |1;ext.html;571.894199573079;606.6147996022526;618.3723520626562;618.4495798739122;650.3106706890693;43022.784886075606;43803.3429498557;43810;43939.340909886334;47765.163444762744;44897;45431.54568454315;45442.772786136105;45456.318155227695;45603.54396456035;8868.955655221715;9032.458052516837;9037.231835293975;9038.954805225965;9039.683611073613;8741.868871966926;8820.955895220515;8833.469991800512;8836.425632333878;8839.734807955772;8894.73315800527;8936.642534298653;8938.776530586721;8939.284857211407;8939.329550283723;8855.203031727175;8869.822603547926;8900.955495222515;8906.910930890674;8915.554222288893;8467.36494762889;8502.659893604248;8520.062793092755;8522.57387130641;8536.036711556315;42974;43257.567424325665;43335;43335.56664433378;43371.78314108441;3566.732495062855;3632.8365223565;3719.8326075326677;3857.9421308680394;3861.806909654506;31187.220319491968;31599.84200079008;31855.52216716751;32122.03633890987;32295.838520807247;4134.896627584304;4318.157959197958;4322.805473753689;4367.10474352757;4423.788105947026;355545;355798;357038;357821;358118;56999;57231.71384143052;57290;57440.712796436586;57446.7127664359;36252.27495450076;59251.70374148188;59339.109913351334;59396.40603593995;59415;15761.763573546406;16545.91727041357;16603.086830224453;16616.58458538522;16623;11953.282803031672;12003.459844307026;12006.75986480283;12037.097217708706;12054.337011464278;18647;18724;18772.436826895217;18814.247430102918;18881.52796180079;6945.652717364112;7073.610951397723;7238.819029524198;7242.275772422716;7308.342249197598;955.350361754014;984.2962281968283;996.8853581838036;1065.9093977011885;1102.608573956234;31681.20796980094;31863.681363186533;31865.522017169762;31964.20089497781;32053.839730801665;929.9395539289925;1119.6920846767205;1142.9142814288962;1174.0138283841613;1191.3090407563593;16165.757513637305;16981.83018169827;17556;17582.736258956127;18564.907175464305;515314.270285946;517465;518324;518498;518720;58544;58972.41027589669;59064.70467647634;59068.40931590629;59136;1226.45422786859;1269.51123817331;1317.3676635214958;1340.987554396444;1372.478458185883;29452.116436506938;32338.514922276656;32346.83826580852;32727.163665810574;33088;48548.514514855815;49210;49216.26175607297;49252.26121608107;49265.50734492609;417412;418411;419001;419650;422508.42441028834;27662.3084422883;43824.780876095414;44588.55411445974;44666.77666611776;45810.77094614506;44985.77507112444;46251.3062304059;47160.7641961788;49801.25298120458;51301.48698512967;40320.74907859372;42598.148037039704;42967.785161073996;43251;43693.34459983166;41782.58217417787;42927.356089659304;43209.78395108004;43385.78307108444;43462.56537434712;42565.787171063945;43085.3537196936;43902.560974389846;43911.34132988071;43968.78015609901;35136;38310;38594.421083683206;38757.41863872101;39631.801840991764;28576;28826.855865720536;29105.563416548346;29224.853875730485;29402.705972940854 21:36:24 INFO - PROCESS | 28189 | |2;jquery.html;373.8859647807421;398.58746197685383;405.28669541606763;406.6035615275107;427.52758202186584;13415.195088294697;15450.845491545095;18932.337368192115;19222.231110755554;19674.40976770699;17911.193996270165;18493;18506.814931850677;18536.536586585342;19157.521061973457;5704.773473703153;5706.315242170935;5947.732352044147;5949.613275137124;5956.047032474805;5780.826575202751;5841;5874.970625146868;5884.058550631899;5888.852778680524;5576.498115169634;5682.460166284196;5858;5858.8242352729485;5862.06207006879;5712.828615141552;5733.512651424634;5756.5682573807135;5760.049591817345;5760.971195144019;5018.623603229772;5096.51583099605;5100.872478188038;5222.399424066243;5269.077911365534;23402.063917443284;23437.179698710464;23519.4120146996;23541.17605883803;23674.881625591934;2309.180241014449;2342.4495243617907;2378.096323397115;2536.556102682042;2836.858157092158;14511.274436278143;14847.925760371128;14855.777163342558;15019.474318398912;15305.1582162981;1858.256697321069;1904.2002359009111;1921.6156768646188;1944.6888497840278;1992.571597106629;81353;81832;82125;82694.58652706759;83483;10649.787004259872;10726.839097413545;10970.506327215295;11118.777624447628;11378.487968041458;15356.308966096329;15501;15516.379344826306;15518.456854010281;15522;7827.25641064098;7869.291763741291;8055.227849873018;8200.302974247137;8259.917400826034;7565.773026809205;7588.127365352944;7673.232676732394;7789.961050194713;7910.011248593926;6454.77408290717;6471.9029214561815;6480.870382592322;6551.639659818756;6555.3772391622715;1920.6542822292122;1972.8914909680104;2007.2974458939254;2009.4976255936017;2017.5964807038358;1001.979960400788;1005.2561104782409;1028.9588416463407;1042.8487869259068;1079.994600026995;19248.80751192498;20125.49686257855;20191.394258172277;20291.695624565644;20485;988.8170688422665;1013.8175128476945;1037.865077539915;1043.2801367056707;1077.8167711489066;10256.641017564349;11356.886431135748;11456;11477.942610286895;11487.36819474937;436313;442591;446758;447286;447364;77908.22091779123;79434;79461.60269198618;79494.602526987;82639.5868020656;989.6536212325773;1006.9024763008356;1034.250168627739;1046.3721766939927;1047.4553232319304;16667.249973750968;16991.235394407035;17193.398231061852;17640.206190721707;17993.910030449762;37779;39214.607853922236;39318.803405982784;39401.60598393979;40706.59293407028;51787.48212517826;51849.25959625225;52293.215601766766;52476.47523524716;52802.679933001986;8562.48625082497;8580.399372044147;8597.785055373415;8622.65509379643;8938.955305223431;12326.568570100004;12463.688407789878;12584.622461326175;12733.936330318289;12969.740605187655;11164.553417863195;11479.8278025828;11586.262060690964;11639.5344186235;12169.452374642986;10170.491475426346;10908.61819836302;11166.888331116585;11248.156388271076;11747.236429632047;6623.735050597922;11362.318260904372;11452.14108941816;11627.941860290644;11906.285622862655;7398.482106252511;7979.361651067785;8392.160783921803;8602.82794344097;8710.869336959824;11558.30650160993;11751.236169648946;11771.23486973344;11850;12130.33283169434 21:36:24 INFO - PROCESS | 28189 | |3;mootools.html;1316.3023597493332;1459.7080583883223;1494.0736743219206;1621.1569983608524;1785.1520527749328;7881.330086942609;8736.388452808305;9027.684031058914;9043.050479699627;9288.489133097677;9066.138716821892;9157.679481218158;9164.175224229817;9166.358354915143;9171.541422928844;2256.289268880306;2273.886305684709;2276.7723227677266;2278.5556816420803;2280.1107568048474;2198.16469741498;2255.706758121442;2291.793738563529;2292.3925159832656;2296.437372843647;2246.764089770575;2257.9435514112197;2263.920762773303;2266.444721043347;2270.829687773415;2176.978230217709;2195.9121635134575;2200.19692812124;2203.7575866654656;2206.8344874134423;2190.835687323457;2218.3455880515285;2235.083615717564;2242.618754811686;2249.302716157996;9024.684136055206;9094.363394562382;9096.77258068547;9100.226480749145;9102.86345704815;5021.59827213822;5182.455842136559;5199.6360254782185;5235.842924712265;5243.501867322599;2992.311768293283;3141.198994256473;3193.5209718542174;3199.42410366134;3202.7758056936023;1071.5071067309048;1073.5276478349501;1075.725689949058;1097.5609756097545;1111.3220935229504;12974.35128243584;13023;13027.934860325639;13044.608661740163;13087;4208.978955105266;4250.808713607895;4402.911941761146;4467.910641787146;4489.910201795946;10041.397516148909;10045;10047.045530674573;10047.346922450017;10053.547590358452;5138.203578445347;5140.948590514122;5157.922631160535;5158.09733296679;5160.7935682573025;4037.2329257440992;4211.115665710174;4289.227938971015;4339.913201736011;4862.586680132228;3353.245519758084;3749.887503374903;3782.111203867089;3801.9809900950872;3804.2581696568905;1083.090204228452;1105.0883021507289;1109.91120710343;1110.3337997201616;1123.6572845282267;900.7793090692822;953.6614501851743;977.4379731654327;984.6209209454269;1004.0110491166196;5920.904632642889;5959.284885813643;5981.820545383645;6104.877902441926;6278.183836101369;452.65598145409723;453.5328611530129;455.4921262792029;467.8596421073664;469.82146784221777;3947.921041579152;3956.3669812829808;3990.10222699896;3999.440078389028;4086.1010577672864;10577.788444231071;11370.20408571392;11456.427178641035;11460.312381257152;11475.254108482923;11194.944025279985;11270.267432616854;11290;11309.604163854226;11444.542218311175;8230.341572674171;8315.334773218248;8364;8378.245957863943;8391.118932512121;5683.72116273835;5757.280339957505;5805.854853628524;5810.389909059657;5986.161937328865;10401.375917444977;10519.105876000625;10527.368357898551;10537.683869483928;10554.788904222027;9236.445813251226;10022.398656080659;10461.320014199053;10478.79042419132;10790.136789057013;7001.159860816734;7452.552846829208;7584.317411432998;7653.693852245848;7841.803954901173;8258.380621453534;8277.710280140167;8329.916700832913;8334.49993000422;8444.619992100248;7456.96271518639;7521.7743467696055;7536.472446928662;7581;7622;7292.635368231673;7382.298681625237;7542.622868856645;7579.734709285149;7593.658285377282;6717.630530320879;6732.293109223657;6740.966295168493;6826.624535650587;6839.658017099225;4797.736124513185;4859.635527335393;4890.731009794353;4966.329545511454;5123.462036486116;4687.437507499122;4845.927311090266;4968.2050871861775;5065.696058236517;5150.665206761549 21:36:24 INFO - PROCESS | 28189 | |4;prototype.html;328.9090697403655;337.55611371047075;344.78967829623934;347.0525465479242;350.353597612405;5027.34644496215;5174.922376164361;5206.973965130173;5218.739063046847;5240.213967904811;4995.900081998358;5091.338126043609;5120.436751957282;5121.411037730662;5122.718250496221;4061.2689715851134;4064.4919385076864;4066.227416790815;4068.369402742565;4094.733842300241;3837.0431080149187;3886.6113388661192;4096.651784598313;4124.237016152007;4142;4044.5550989391145;4047.7571345719202;4055.3105971984833;4078.4697989261504;4092.1201941582553;4080.204360149772;4082.612151845585;4086.5504794472436;4088.3049881520215;4105.507339119295;3686.0600546860646;3688.4098544232793;3690.1328187876097;3705.3515634763808;3708.128589781399;4894.804207831682;4980.858230960685;5024.497550244982;5029.127571769717;5042.4201216860165;4681.250999840044;4699.506551812045;4709;4713.387259656222;4720.457147428056;5361.463853614647;5371.623986320959;5373.516383525502;5374.973125134388;5414.7834086636485;3735.6451137141926;3884.436756670267;3927.371620540728;3929.9410508842107;3942.8028598570245;5576.776928922838;5593.552515798727;5604.887902241932;5617.634853734494;5619.606627536034;4030.334994725896;4031.9395209071886;4055.6958228133008;4067.3695577185586;4080.714349995472;3996.9200615987515;4006.9181321043156;4034.899127521777;4063.7358571692744;4107.863910766445;4595.977020114878;4606.792694328697;4609.00906305146;4611.746353950565;4628.4445866496235;5404.891902161935;5430.755615997289;5445.156000819879;5479.0959491684225;5483.232347471358;1357.3484727330936;1370.5198385743374;1390.9095908765898;1398.2868736944029;1404.8339877901317;890.6036813618007;907.9150415253708;924.426855349674;928.8853375948888;929.3328148214667;4635.837745678885;4661.86014419568;4663.481719871299;4686.601638860667;4689.460712018162;4903.705777653352;4926;4926.729029903389;4928.102680467974;4935.864751107266;4410.170862905114;4632.25883858581;4641.002184530342;4658.440987081572;4659.254519276899;2544.8727563621746;2591.2614904752054;2594.507043661736;2597.882910348568;2612.673415823022;5029.748512574357;5042.705568966112;5043.798248070036;5059.62052846038;5065.493450654905;4538.275455326954;4906.607471402351;4923.901521969612;4974.477679843637;4981.452040275567;5078.847634570969;5094.5669618082875;5100.336956195671;5103.948960510347;5154.664946778447;4957.677750946177;4963.454020057863;4979.477154898828;5010.223415370623;5012.899742005213;4831.347768051268;4876.829310974099;4928.630352723489;4950.183219768698;5016.6237532184505;5710.885782284248;5721.6280941740315;5724.398938111438;5737.426257374229;5833.562482813721;3873.554541227682;4035.273650742777;4040;4052.068024354474;4053;5230;5513.58648101386;5515.22786809855;5521.585881058856;5521.812810245817;5401.864953376197;5421.400686797326;5427;5432.429594892479;5449.5640348772795;5300.70846103468;5351.170568561879;5392.784288628568;5439.184122381675;5447.155690867922;5379.973100134631;5380.3274590676165;5382.273393091882;5383.757730902041;5386.676799392049;5444.713220447343;5446.1558458439;5452.809151679672;5474.397816240131;5477.3427188737605;5087.880666253418;5284.709340986129;5298.178782288752;5313.814016509404;5334.226537152013 21:36:24 INFO - PROCESS | 28189 | |5;yui.html;708.4615692074024;729.9708011679533;769.127040808682;770.8766597344422;816.1573496104256;15525.378984840607;17322.653546929054;17331.133443327846;17339.219735111918;17345.306187752507;14770.409183632668;14964.476243331459;14991.100533967969;15009;15022.323995420205;660.0890770736377;673.7810211681199;792.1998781230955;816.2327412232482;820.5774026376421;782.765170448863;810.7689308547066;814.2020819596798;821.2157389692829;821.2485575698258;842.8862103616025;845.0619812008665;845.1590667286029;845.7251393297172;845.8646616541355;681.6285124607101;835.3192148399036;836.8451836410222;836.9163083691612;837.5937670229964;515.7782153673919;612.2347066167291;625.5683578330983;627.5293529852611;627.9277883043417;15353.15557644329;15528.844711552965;15547;15548.533543993699;15551.30019149141;13785.310734463237;13995.860041399557;14241.359138838778;14480.493182738554;14620.780688289684;12928.35358232094;12983.221006739626;12995.87004129956;13068.150570212905;13349.799753003712;4339.240632889232;4412.933805992912;4417.779111044435;4425.137098265839;4441.666874984389;80939.19060809375;80990.19009809944;81007.5949620254;81151;81407.18592814055;11075.446227688582;11153.832692509619;11456.312621242752;11595.942020289845;11965.521379144911;21417.78582214189;21517;21667.56664866694;21717.565648687254;21729.348119556438;8316.584170791557;8387;8418.831623367498;8667.653293868174;8711.912880871238;4584.541545845455;4651.720896746206;4757.333973243749;4769.76151192439;4990.850274491771;3302.7688061835443;3408.113890388467;3411.2836304375865;3411.522386865841;3413.4026545354463;577.3072313224064;578.3811321885543;583.8423625621143;606.0333767640606;607.0954278125649;612.9938700612937;658.973641054362;667.9632620205936;679.1646275081678;727.31995584129;8899.150277257013;8987.955060224656;9245.3528253023;9277.953610231905;9282.164605185566;614.9600275982136;639.7984634840011;674.2717864706106;676.235853485568;702.2310569925922;4178.477690288714;4379.715318504287;4465.598096171295;4466.798994045275;4467.15124126415;66760.33239667639;91495.54252228697;114874;129636;130089;107884;110064;111310;111351;112688;76097.61951190208;91162;91844;97750.51124744331;98252.50873745585;7991;8034.317083048007;8371.874421883798;8496.150384961455;8566.602436137024;56523.43476565346;56599.151012734015;56684;56989.31181699038;59527;75883.24116758762;77849.61075194587;84072;84157.579212106;85718.57140714256;11362.886371136183;11486.597969071043;11615.88384116148;11750.471228794895;12022.458989345325;12464.314462704639;12575.182613130117;12873.420696068511;13255.80116298237;13824.654383640489;11868.584599538975;11871.821922671339;11909.702257443632;11943.701407464883;12058.216215945935;11324.490397932277;11423.714407139556;11564.884351156717;11679.182457227913;11826.467808948446;11179.441027948733;11492.540298388305;11832;11868.82196767032;11916.285022898654;10023.498825058863;10126.291159618757;10201.183905287708;10306.690799276033;10484.907111144303;10054.19566434669;10287.435747024643;10482.842757358494;10511.94744026275;10528.947355263175 21:36:24 INFO - PROCESS | 28189 | __end_tp_report 21:36:24 INFO - PROCESS | 28189 | __start_cc_report 21:36:24 INFO - PROCESS | 28189 | _x_x_mozilla_cycle_collect,1241 21:36:24 INFO - PROCESS | 28189 | __end_cc_report 21:36:24 INFO - PROCESS | 28189 | __startTimestamp1476160584158__endTimestamp 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | ------- Summary: start ------- 21:36:24 INFO - PROCESS | 28189 | Number of tests: 6 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#0] dojo.html Cycles:165 Average:5041.94 Median:5226.53 stddev:557.19 (10.7%) stddev-sans-first:533.43 21:36:24 INFO - PROCESS | 28189 | Values: 2919.0 2961.1 2966.4 2996.9 3015.8 4976.2 5030.1 5034.3 5103.7 5161.7 5102.3 5102.4 5121.1 5155.8 5226.8 4608.8 4621.5 4635.6 4643.4 4694.0 4661.8 4701.8 4705.5 4725.9 4751.7 4504.6 4558.1 4564.9 4595.4 4596.4 4507.2 4524.1 4525.9 4564.9 4594.5 4495.6 4498.0 4502.3 4518.1 4549.5 4894.3 4928.7 4982.7 4987.3 4987.4 5384.6 5409.9 5434.6 5451.3 5504.0 5487.6 5488.5 5500.1 5505.8 5505.9 4939.4 5144.6 5144.6 5151.2 5212.5 5363.5 5534.9 5595.6 5598.4 5672.5 5371.2 5377.1 5379.1 5382.4 5383.0 5437.5 5452.6 5454.3 5458.3 5520.2 5162.2 5255.1 5257.4 5365.0 5419.1 5429.3 5447.3 5471.2 5499.2 5504.8 4235.6 4235.7 4237.6 4286.6 4287.9 3774.7 3789.0 3816.9 3819.1 3843.7 5094.3 5167.4 5170.3 5236.7 5241.5 5459.3 5461.5 5462.6 5463.5 5518.5 5112.8 5114.6 5119.7 5119.9 5178.9 4647.1 4670.4 4677.3 4681.8 4759.6 5552.6 5557.4 5562.1 5610.7 5620.2 5363.3 5366.2 5370.5 5373.1 5373.5 5483.5 5531.6 5560.5 5594.1 5622.0 5370.2 5381.1 5382.0 5443.6 5445.5 5331.8 5391.4 5451.5 5462.0 5464.9 5119.5 5174.5 5223.5 5281.5 5286.6 5183.6 5226.5 5231.5 5257.1 5308.5 5217.9 5223.5 5232.7 5233.3 5287.1 5232.9 5304.6 5304.7 5310.7 5317.4 5169.0 5188.0 5203.2 5245.5 5248.6 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#1] ext.html Cycles:180 Average:59891.14 Median:43378.78 stddev:115400.11 (266.0%) stddev-sans-first:115637.89 21:36:24 INFO - PROCESS | 28189 | Values: 571.9 606.6 618.4 618.4 650.3 43022.8 43803.3 43810.0 43939.3 47765.2 44897.0 45431.5 45442.8 45456.3 45603.5 8869.0 9032.5 9037.2 9039.0 9039.7 8741.9 8821.0 8833.5 8836.4 8839.7 8894.7 8936.6 8938.8 8939.3 8939.3 8855.2 8869.8 8901.0 8906.9 8915.6 8467.4 8502.7 8520.1 8522.6 8536.0 42974.0 43257.6 43335.0 43335.6 43371.8 3566.7 3632.8 3719.8 3857.9 3861.8 31187.2 31599.8 31855.5 32122.0 32295.8 4134.9 4318.2 4322.8 4367.1 4423.8 355545.0 355798.0 357038.0 357821.0 358118.0 56999.0 57231.7 57290.0 57440.7 57446.7 36252.3 59251.7 59339.1 59396.4 59415.0 15761.8 16545.9 16603.1 16616.6 16623.0 11953.3 12003.5 12006.8 12037.1 12054.3 18647.0 18724.0 18772.4 18814.2 18881.5 6945.7 7073.6 7238.8 7242.3 7308.3 955.4 984.3 996.9 1065.9 1102.6 31681.2 31863.7 31865.5 31964.2 32053.8 929.9 1119.7 1142.9 1174.0 1191.3 16165.8 16981.8 17556.0 17582.7 18564.9 515314.3 517465.0 518324.0 518498.0 518720.0 58544.0 58972.4 59064.7 59068.4 59136.0 1226.5 1269.5 1317.4 1341.0 1372.5 29452.1 32338.5 32346.8 32727.2 33088.0 48548.5 49210.0 49216.3 49252.3 49265.5 417412.0 418411.0 419001.0 419650.0 422508.4 27662.3 43824.8 44588.6 44666.8 45810.8 44985.8 46251.3 47160.8 49801.3 51301.5 40320.7 42598.1 42967.8 43251.0 43693.3 41782.6 42927.4 43209.8 43385.8 43462.6 42565.8 43085.4 43902.6 43911.3 43968.8 35136.0 38310.0 38594.4 38757.4 39631.8 28576.0 28826.9 29105.6 29224.9 29402.7 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#2] jquery.html Cycles:180 Average:27278.61 Median:23478.30 stddev:73158.92 (311.6%) stddev-sans-first:73336.26 21:36:24 INFO - PROCESS | 28189 | Values: 373.9 398.6 405.3 406.6 427.5 13415.2 15450.8 18932.3 19222.2 19674.4 17911.2 18493.0 18506.8 18536.5 19157.5 5704.8 5706.3 5947.7 5949.6 5956.0 5780.8 5841.0 5875.0 5884.1 5888.9 5576.5 5682.5 5858.0 5858.8 5862.1 5712.8 5733.5 5756.6 5760.0 5761.0 5018.6 5096.5 5100.9 5222.4 5269.1 23402.1 23437.2 23519.4 23541.2 23674.9 2309.2 2342.4 2378.1 2536.6 2836.9 14511.3 14847.9 14855.8 15019.5 15305.2 1858.3 1904.2 1921.6 1944.7 1992.6 81353.0 81832.0 82125.0 82694.6 83483.0 10649.8 10726.8 10970.5 11118.8 11378.5 15356.3 15501.0 15516.4 15518.5 15522.0 7827.3 7869.3 8055.2 8200.3 8259.9 7565.8 7588.1 7673.2 7790.0 7910.0 6454.8 6471.9 6480.9 6551.6 6555.4 1920.7 1972.9 2007.3 2009.5 2017.6 1002.0 1005.3 1029.0 1042.8 1080.0 19248.8 20125.5 20191.4 20291.7 20485.0 988.8 1013.8 1037.9 1043.3 1077.8 10256.6 11356.9 11456.0 11477.9 11487.4 436313.0 442591.0 446758.0 447286.0 447364.0 77908.2 79434.0 79461.6 79494.6 82639.6 989.7 1006.9 1034.3 1046.4 1047.5 16667.2 16991.2 17193.4 17640.2 17993.9 37779.0 39214.6 39318.8 39401.6 40706.6 51787.5 51849.3 52293.2 52476.5 52802.7 8562.5 8580.4 8597.8 8622.7 8939.0 12326.6 12463.7 12584.6 12733.9 12969.7 11164.6 11479.8 11586.3 11639.5 12169.5 10170.5 10908.6 11166.9 11248.2 11747.2 6623.7 11362.3 11452.1 11627.9 11906.3 7398.5 7979.4 8392.2 8602.8 8710.9 11558.3 11751.2 11771.2 11850.0 12130.3 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#3] mootools.html Cycles:180 Average:5759.13 Median:4371.41 stddev:3446.40 (78.8%) stddev-sans-first:3439.90 21:36:24 INFO - PROCESS | 28189 | Values: 1316.3 1459.7 1494.1 1621.2 1785.2 7881.3 8736.4 9027.7 9043.1 9288.5 9066.1 9157.7 9164.2 9166.4 9171.5 2256.3 2273.9 2276.8 2278.6 2280.1 2198.2 2255.7 2291.8 2292.4 2296.4 2246.8 2257.9 2263.9 2266.4 2270.8 2177.0 2195.9 2200.2 2203.8 2206.8 2190.8 2218.3 2235.1 2242.6 2249.3 9024.7 9094.4 9096.8 9100.2 9102.9 5021.6 5182.5 5199.6 5235.8 5243.5 2992.3 3141.2 3193.5 3199.4 3202.8 1071.5 1073.5 1075.7 1097.6 1111.3 12974.4 13023.0 13027.9 13044.6 13087.0 4209.0 4250.8 4402.9 4467.9 4489.9 10041.4 10045.0 10047.0 10047.3 10053.5 5138.2 5140.9 5157.9 5158.1 5160.8 4037.2 4211.1 4289.2 4339.9 4862.6 3353.2 3749.9 3782.1 3802.0 3804.3 1083.1 1105.1 1109.9 1110.3 1123.7 900.8 953.7 977.4 984.6 1004.0 5920.9 5959.3 5981.8 6104.9 6278.2 452.7 453.5 455.5 467.9 469.8 3947.9 3956.4 3990.1 3999.4 4086.1 10577.8 11370.2 11456.4 11460.3 11475.3 11194.9 11270.3 11290.0 11309.6 11444.5 8230.3 8315.3 8364.0 8378.2 8391.1 5683.7 5757.3 5805.9 5810.4 5986.2 10401.4 10519.1 10527.4 10537.7 10554.8 9236.4 10022.4 10461.3 10478.8 10790.1 7001.2 7452.6 7584.3 7653.7 7841.8 8258.4 8277.7 8329.9 8334.5 8444.6 7457.0 7521.8 7536.5 7581.0 7622.0 7292.6 7382.3 7542.6 7579.7 7593.7 6717.6 6732.3 6741.0 6826.6 6839.7 4797.7 4859.6 4890.7 4966.3 5123.5 4687.4 4845.9 4968.2 5065.7 5150.7 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#4] prototype.html Cycles:180 Average:4427.83 Median:4932.25 stddev:1269.48 (25.7%) stddev-sans-first:1235.20 21:36:24 INFO - PROCESS | 28189 | Values: 328.9 337.6 344.8 347.1 350.4 5027.3 5174.9 5207.0 5218.7 5240.2 4995.9 5091.3 5120.4 5121.4 5122.7 4061.3 4064.5 4066.2 4068.4 4094.7 3837.0 3886.6 4096.7 4124.2 4142.0 4044.6 4047.8 4055.3 4078.5 4092.1 4080.2 4082.6 4086.6 4088.3 4105.5 3686.1 3688.4 3690.1 3705.4 3708.1 4894.8 4980.9 5024.5 5029.1 5042.4 4681.3 4699.5 4709.0 4713.4 4720.5 5361.5 5371.6 5373.5 5375.0 5414.8 3735.6 3884.4 3927.4 3929.9 3942.8 5576.8 5593.6 5604.9 5617.6 5619.6 4030.3 4031.9 4055.7 4067.4 4080.7 3996.9 4006.9 4034.9 4063.7 4107.9 4596.0 4606.8 4609.0 4611.7 4628.4 5404.9 5430.8 5445.2 5479.1 5483.2 1357.3 1370.5 1390.9 1398.3 1404.8 890.6 907.9 924.4 928.9 929.3 4635.8 4661.9 4663.5 4686.6 4689.5 4903.7 4926.0 4926.7 4928.1 4935.9 4410.2 4632.3 4641.0 4658.4 4659.3 2544.9 2591.3 2594.5 2597.9 2612.7 5029.7 5042.7 5043.8 5059.6 5065.5 4538.3 4906.6 4923.9 4974.5 4981.5 5078.8 5094.6 5100.3 5103.9 5154.7 4957.7 4963.5 4979.5 5010.2 5012.9 4831.3 4876.8 4928.6 4950.2 5016.6 5710.9 5721.6 5724.4 5737.4 5833.6 3873.6 4035.3 4040.0 4052.1 4053.0 5230.0 5513.6 5515.2 5521.6 5521.8 5401.9 5421.4 5427.0 5432.4 5449.6 5300.7 5351.2 5392.8 5439.2 5447.2 5380.0 5380.3 5382.3 5383.8 5386.7 5444.7 5446.2 5452.8 5474.4 5477.3 5087.9 5284.7 5298.2 5313.8 5334.2 21:36:24 INFO - PROCESS | 28189 | 21:36:24 INFO - PROCESS | 28189 | [#5] yui.html Cycles:180 Average:21269.33 Median:4466.20 stddev:31595.58 (707.4%) stddev-sans-first:31646.50 21:36:24 INFO - PROCESS | 28189 | Values: 708.5 730.0 769.1 770.9 816.2 15525.4 17322.7 17331.1 17339.2 17345.3 14770.4 14964.5 14991.1 15009.0 15022.3 660.1 673.8 792.2 816.2 820.6 782.8 810.8 814.2 821.2 821.2 842.9 845.1 845.2 845.7 845.9 681.6 835.3 836.8 836.9 837.6 515.8 612.2 625.6 627.5 627.9 15353.2 15528.8 15547.0 15548.5 15551.3 13785.3 13995.9 14241.4 14480.5 14620.8 12928.4 12983.2 12995.9 13068.2 13349.8 4339.2 4412.9 4417.8 4425.1 4441.7 80939.2 80990.2 81007.6 81151.0 81407.2 11075.4 11153.8 11456.3 11595.9 11965.5 21417.8 21517.0 21667.6 21717.6 21729.3 8316.6 8387.0 8418.8 8667.7 8711.9 4584.5 4651.7 4757.3 4769.8 4990.9 3302.8 3408.1 3411.3 3411.5 3413.4 577.3 578.4 583.8 606.0 607.1 613.0 659.0 668.0 679.2 727.3 8899.2 8988.0 9245.4 9278.0 9282.2 615.0 639.8 674.3 676.2 702.2 4178.5 4379.7 4465.6 4466.8 4467.2 66760.3 91495.5 114874.0 129636.0 130089.0 107884.0 110064.0 111310.0 111351.0 112688.0 76097.6 91162.0 91844.0 97750.5 98252.5 7991.0 8034.3 8371.9 8496.2 8566.6 56523.4 56599.2 56684.0 56989.3 59527.0 75883.2 77849.6 84072.0 84157.6 85718.6 11362.9 11486.6 11615.9 11750.5 12022.5 12464.3 12575.2 12873.4 13255.8 13824.7 11868.6 11871.8 11909.7 11943.7 12058.2 11324.5 11423.7 11564.9 11679.2 11826.5 11179.4 11492.5 11832.0 11868.8 11916.3 10023.5 10126.3 10201.2 10306.7 10484.9 10054.2 10287.4 10482.8 10511.9 10528.9 21:36:24 INFO - PROCESS | 28189 | -------- Summary: end -------- 21:36:24 INFO - PROCESS | 28189 | 21:36:25 INFO - TEST-INFO | 28189: exit 0 21:36:25 INFO - TEST-OK | dromaeo_css | took 1115756ms 21:36:25 INFO - TEST-START | kraken 21:36:25 INFO - operating with platform_type : linux_ 21:36:25 INFO - Initialising browser for kraken test... 21:36:25 INFO - TEST-INFO | started process 28497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRLnOP/profile http://localhost:51270/getInfo.html) 21:36:28 INFO - PROCESS | 28497 | __metrics Screen width/height:1600/1200 21:36:28 INFO - PROCESS | 28497 | colorDepth:24 21:36:28 INFO - PROCESS | 28497 | Browser inner width/height: 1024/697 21:36:28 INFO - PROCESS | 28497 | __metrics 21:36:29 INFO - PROCESS | 28497 | 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" 21:36:29 INFO - PROCESS | 28497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:36:29 INFO - PROCESS | 28497 | console.error: PushService: 21:36:29 INFO - PROCESS | 28497 | stateChangeProcessEnqueue: Error transitioning state 21:36:29 INFO - PROCESS | 28497 | UnknownError 21:36:30 INFO - TEST-INFO | 28497: exit 0 21:36:30 INFO - Browser initialized. 21:36:30 INFO - Running cycle 1/1 for kraken test... 21:36:30 INFO - TEST-INFO | started process 28585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRLnOP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:42 INFO - PROCESS | 28585 | RSS: Main: 173150208 21:36:42 INFO - PROCESS | 28585 | 21:36:45 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51270/tests/kraken/driver.html?testName=audio-beat-detection) 21:36:46 INFO - PROCESS | 28585 | RSS: Main: 231460864 21:36:46 INFO - PROCESS | 28585 | 21:36:48 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51270/tests/kraken/driver.html?testName=audio-dft) 21:36:49 INFO - PROCESS | 28585 | RSS: Main: 217079808 21:36:49 INFO - PROCESS | 28585 | 21:36:52 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51270/tests/kraken/driver.html?testName=audio-fft) 21:36:53 INFO - PROCESS | 28585 | RSS: Main: 298631168 21:36:53 INFO - PROCESS | 28585 | 21:36:55 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51270/tests/kraken/driver.html?testName=audio-oscillator) 21:36:55 INFO - PROCESS | 28585 | RSS: Main: 210583552 21:36:55 INFO - PROCESS | 28585 | 21:36:57 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:36:58 INFO - PROCESS | 28585 | RSS: Main: 212738048 21:36:58 INFO - PROCESS | 28585 | 21:37:01 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51270/tests/kraken/driver.html?testName=imaging-darkroom) 21:37:02 INFO - PROCESS | 28585 | RSS: Main: 248446976 21:37:02 INFO - PROCESS | 28585 | 21:37:05 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51270/tests/kraken/driver.html?testName=imaging-desaturate) 21:37:06 INFO - PROCESS | 28585 | RSS: Main: 247533568 21:37:06 INFO - PROCESS | 28585 | 21:37:08 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51270/tests/kraken/driver.html?testName=json-parse-financial) 21:37:09 INFO - PROCESS | 28585 | RSS: Main: 247726080 21:37:09 INFO - PROCESS | 28585 | 21:37:10 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:37:11 INFO - PROCESS | 28585 | RSS: Main: 209670144 21:37:11 INFO - PROCESS | 28585 | 21:37:13 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:37:13 INFO - PROCESS | 28585 | RSS: Main: 216510464 21:37:13 INFO - PROCESS | 28585 | 21:37:15 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:37:16 INFO - PROCESS | 28585 | RSS: Main: 226705408 21:37:16 INFO - PROCESS | 28585 | 21:37:19 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:37:19 INFO - PROCESS | 28585 | RSS: Main: 235614208 21:37:19 INFO - PROCESS | 28585 | 21:37:22 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:37:23 INFO - PROCESS | 28585 | RSS: Main: 231976960 21:37:23 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:51270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51270/tests/kraken/driver.html?testName=ai-astar) 21:37:25 INFO - PROCESS | 28585 | RSS: Main: 282931200 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | __start_tp_report 21:37:25 INFO - PROCESS | 28585 | _x_x_mozilla_page_load 21:37:25 INFO - PROCESS | 28585 | _x_x_mozilla_page_load_details 21:37:25 INFO - PROCESS | 28585 | |i|pagename|runs| 21:37:25 INFO - PROCESS | 28585 | |0;ai-astar;111;113;113;112;112;112;113;111;112;113 21:37:25 INFO - PROCESS | 28585 | |1;audio-beat-detection;153;122;123;163;122;124;119;119;153;127 21:37:25 INFO - PROCESS | 28585 | |2;audio-dft;161;161;160;162;161;164;160;161;159;161 21:37:25 INFO - PROCESS | 28585 | |3;audio-fft;74;75;76;112;76;76;76;76;97;75 21:37:25 INFO - PROCESS | 28585 | |4;audio-oscillator;84;83;122;83;84;84;106;83;83;110 21:37:25 INFO - PROCESS | 28585 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;117 21:37:25 INFO - PROCESS | 28585 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;146;146 21:37:25 INFO - PROCESS | 28585 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 21:37:25 INFO - PROCESS | 28585 | |8;json-parse-financial;51;51;50;50;50;52;54;53;52;51 21:37:25 INFO - PROCESS | 28585 | |9;json-stringify-tinderbox;59;60;59;59;60;60;59;60;59;59 21:37:25 INFO - PROCESS | 28585 | |10;stanford-crypto-aes;81;80;80;80;85;85;88;80;88;80 21:37:25 INFO - PROCESS | 28585 | |11;stanford-crypto-ccm;132;140;140;128;139;133;131;138;170;132 21:37:25 INFO - PROCESS | 28585 | |12;stanford-crypto-pbkdf2;164;165;166;165;167;164;173;166;163;165 21:37:25 INFO - PROCESS | 28585 | |13;stanford-crypto-sha256-iterative;66;66;65;75;65;66;67;66;64;65 21:37:25 INFO - PROCESS | 28585 | __end_tp_report 21:37:25 INFO - PROCESS | 28585 | __start_cc_report 21:37:25 INFO - PROCESS | 28585 | _x_x_mozilla_cycle_collect,1664 21:37:25 INFO - PROCESS | 28585 | __end_cc_report 21:37:25 INFO - PROCESS | 28585 | __startTimestamp1476160645256__endTimestamp 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | ------- Summary: start ------- 21:37:25 INFO - PROCESS | 28585 | Number of tests: 14 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 21:37:25 INFO - PROCESS | 28585 | Values: 111.0 113.0 113.0 112.0 112.0 112.0 113.0 111.0 112.0 113.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:125.50 stddev:16.83 (13.4%) stddev-sans-first:16.13 21:37:25 INFO - PROCESS | 28585 | Values: 153.0 122.0 123.0 163.0 122.0 124.0 119.0 119.0 153.0 127.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 21:37:25 INFO - PROCESS | 28585 | Values: 161.0 161.0 160.0 162.0 161.0 164.0 160.0 161.0 159.0 161.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.24 21:37:25 INFO - PROCESS | 28585 | Values: 74.0 75.0 76.0 112.0 76.0 76.0 76.0 76.0 97.0 75.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.00 stddev:14.67 (17.7%) stddev-sans-first:15.25 21:37:25 INFO - PROCESS | 28585 | Values: 84.0 83.0 122.0 83.0 84.0 84.0 106.0 83.0 83.0 110.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 21:37:25 INFO - PROCESS | 28585 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 21:37:25 INFO - PROCESS | 28585 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:37:25 INFO - PROCESS | 28585 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.35 (2.6%) stddev-sans-first:1.42 21:37:25 INFO - PROCESS | 28585 | Values: 51.0 51.0 50.0 50.0 50.0 52.0 54.0 53.0 52.0 51.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 21:37:25 INFO - PROCESS | 28585 | Values: 59.0 60.0 59.0 59.0 60.0 60.0 59.0 60.0 59.0 59.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:3.43 (4.1%) stddev-sans-first:3.59 21:37:25 INFO - PROCESS | 28585 | Values: 81.0 80.0 80.0 80.0 85.0 85.0 88.0 80.0 88.0 80.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:138.50 stddev:11.92 (8.6%) stddev-sans-first:12.42 21:37:25 INFO - PROCESS | 28585 | Values: 132.0 140.0 140.0 128.0 139.0 133.0 131.0 138.0 170.0 132.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:165.50 stddev:2.78 (1.7%) stddev-sans-first:2.87 21:37:25 INFO - PROCESS | 28585 | Values: 164.0 165.0 166.0 165.0 167.0 164.0 173.0 166.0 163.0 165.0 21:37:25 INFO - PROCESS | 28585 | 21:37:25 INFO - PROCESS | 28585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:3.10 (4.7%) stddev-sans-first:3.28 21:37:25 INFO - PROCESS | 28585 | Values: 66.0 66.0 65.0 75.0 65.0 66.0 67.0 66.0 64.0 65.0 21:37:25 INFO - PROCESS | 28585 | -------- Summary: end -------- 21:37:25 INFO - PROCESS | 28585 | 21:37:26 INFO - TEST-INFO | 28585: exit 0 21:37:26 INFO - TEST-OK | kraken | took 61427ms 21:37:26 INFO - SUITE-END | took 1177s 21:37:26 INFO - Completed test suite (00:19:37) 21:37:26 INFO - javascript benchmark 21:37:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.985405072974, 2961.096865456035, 2966.3622321200946, 2996.8501574921247, 3015.788894777365, 4976.203807390818, 5030.069437154129, 5034.270030845525, 5103.668261563001, 5161.674270977976, 5102.285680004802, 5102.387713474379, 5121.078205922932, 5155.793768249266, 5226.817061402851, 4608.792604332796, 4621.491635920046, 4635.559621835937, 4643.442786865581, 4693.9530604693855, 4661.813527458898, 4701.811927522895, 4705.458872229686, 4725.858224253261, 4751.691140075901, 4504.6396288296855, 4558.133954548658, 4564.931526027112, 4595.356650068993, 4596.3794887690065, 4507.16617425774, 4524.140413321491, 4525.932111018337, 4564.931526027112, 4594.471635761864, 4495.64034877209, 4498.010437703732, 4502.279635258343, 4518.118966801475, 4549.454065512126, 4894.2658601210105, 4928.67963582366, 4982.651214414992, 4987.326710894019, 4987.351644286256, 5384.5692344612335, 5409.9459005409835, 5434.592405569598, 5451.3458384993655, 5504.0, 5487.6158668893195, 5488.506034456918, 5500.092484740013, 5505.834824955217, 5505.862353441156, 4939.431965324034, 5144.614153938394, 5144.6141539384325, 5151.17581187012, 5212.478752124757, 5363.517283444508, 5534.916976245359, 5595.63628364155, 5598.384177740445, 5672.4894759471845, 5371.167469042305, 5377.085895397791, 5379.085555455582, 5382.434844341366, 5382.973085134549, 5437.510624043855, 5452.591055670761, 5454.290942177491, 5458.317710286215, 5520.199571062173, 5162.174052151638, 5255.054090263713, 5257.369115706139, 5365.034293827149, 5419.078756611386, 5429.267048948342, 5447.346318441733, 5471.206675032098, 5499.202615620713, 5504.80733174337, 4235.639970602471, 4235.745855248633, 4237.5762423758, 4286.61420472159, 4287.871363859089, 3774.735768496234, 3789.03379638196, 3816.866409675648, 3819.1406933440308, 3843.673287770515, 5094.337736094284, 5167.354080739908, 5170.250313704491, 5236.685798852005, 5241.50205730455, 5459.2629994950175, 5461.535769459561, 5462.590305727007, 5463.48096930791, 5518.503334699816, 5112.769925353368, 5114.616403769658, 5119.667221630582, 5119.897602047939, 5178.896422071537, 4647.07058588277, 4670.416197975253, 4677.298405239241, 4681.8361357353015, 4759.595434388047, 5552.5557955362665, 5557.41647127054, 5562.137868630369, 5610.747516361774, 5620.185073164368, 5363.329583802025, 5366.195070739421, 5370.543503802221, 5373.143243996642, 5373.543248823894, 5483.4516548344845, 5531.612787104864, 5560.499555040065, 5594.104943209067, 5621.971890140523, 5370.2213179089595, 5381.085215513451, 5381.973090134525, 5443.591730620298, 5445.482679145475, 5331.840044798662, 5391.379991301051, 5451.454854514517, 5461.972690136524, 5464.945350546603, 5119.488051195, 5174.482551744795, 5223.45153758865, 5281.519672188508, 5286.577073834007, 5183.585313175013, 5226.529612334908, 5231.503007214308, 5257.080010997984, 5308.548773354154, 5217.921731173959, 5223.52988231061, 5232.659877107976, 5233.319668443078, 5287.101192797157, 5232.921506177487, 5304.60215483848, 5304.681719096867, 5310.707911064928, 5317.441668624739, 5169.043726910533, 5188.0, 5203.167493201221, 5245.475452454724, 5248.6325957182635], "value": 5005.560017182985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.894199573079, 606.6147996022526, 618.3723520626562, 618.4495798739122, 650.3106706890693, 43022.784886075606, 43803.3429498557, 43810.0, 43939.340909886334, 47765.163444762744, 44897.0, 45431.54568454315, 45442.772786136105, 45456.318155227695, 45603.54396456035, 8868.955655221715, 9032.458052516837, 9037.231835293975, 9038.954805225965, 9039.683611073613, 8741.868871966926, 8820.955895220515, 8833.469991800512, 8836.425632333878, 8839.734807955772, 8894.73315800527, 8936.642534298653, 8938.776530586721, 8939.284857211407, 8939.329550283723, 8855.203031727175, 8869.822603547926, 8900.955495222515, 8906.910930890674, 8915.554222288893, 8467.36494762889, 8502.659893604248, 8520.062793092755, 8522.57387130641, 8536.036711556315, 42974.0, 43257.567424325665, 43335.0, 43335.56664433378, 43371.78314108441, 3566.732495062855, 3632.8365223565, 3719.8326075326677, 3857.9421308680394, 3861.806909654506, 31187.220319491968, 31599.84200079008, 31855.52216716751, 32122.03633890987, 32295.838520807247, 4134.896627584304, 4318.157959197958, 4322.805473753689, 4367.10474352757, 4423.788105947026, 355545.0, 355798.0, 357038.0, 357821.0, 358118.0, 56999.0, 57231.71384143052, 57290.0, 57440.712796436586, 57446.7127664359, 36252.27495450076, 59251.70374148188, 59339.109913351334, 59396.40603593995, 59415.0, 15761.763573546406, 16545.91727041357, 16603.086830224453, 16616.58458538522, 16623.0, 11953.282803031672, 12003.459844307026, 12006.75986480283, 12037.097217708706, 12054.337011464278, 18647.0, 18724.0, 18772.436826895217, 18814.247430102918, 18881.52796180079, 6945.652717364112, 7073.610951397723, 7238.819029524198, 7242.275772422716, 7308.342249197598, 955.350361754014, 984.2962281968283, 996.8853581838036, 1065.9093977011885, 1102.608573956234, 31681.20796980094, 31863.681363186533, 31865.522017169762, 31964.20089497781, 32053.839730801665, 929.9395539289925, 1119.6920846767205, 1142.9142814288962, 1174.0138283841613, 1191.3090407563593, 16165.757513637305, 16981.83018169827, 17556.0, 17582.736258956127, 18564.907175464305, 515314.270285946, 517465.0, 518324.0, 518498.0, 518720.0, 58544.0, 58972.41027589669, 59064.70467647634, 59068.40931590629, 59136.0, 1226.45422786859, 1269.51123817331, 1317.3676635214958, 1340.987554396444, 1372.478458185883, 29452.116436506938, 32338.514922276656, 32346.83826580852, 32727.163665810574, 33088.0, 48548.514514855815, 49210.0, 49216.26175607297, 49252.26121608107, 49265.50734492609, 417412.0, 418411.0, 419001.0, 419650.0, 422508.42441028834, 27662.3084422883, 43824.780876095414, 44588.55411445974, 44666.77666611776, 45810.77094614506, 44985.77507112444, 46251.3062304059, 47160.7641961788, 49801.25298120458, 51301.48698512967, 40320.74907859372, 42598.148037039704, 42967.785161073996, 43251.0, 43693.34459983166, 41782.58217417787, 42927.356089659304, 43209.78395108004, 43385.78307108444, 43462.56537434712, 42565.787171063945, 43085.3537196936, 43902.560974389846, 43911.34132988071, 43968.78015609901, 35136.0, 38310.0, 38594.421083683206, 38757.41863872101, 39631.801840991764, 28576.0, 28826.855865720536, 29105.563416548346, 29224.853875730485, 29402.705972940854], "value": 20337.318466312696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.8859647807421, 398.58746197685383, 405.28669541606763, 406.6035615275107, 427.52758202186584, 13415.195088294697, 15450.845491545095, 18932.337368192115, 19222.231110755554, 19674.40976770699, 17911.193996270165, 18493.0, 18506.814931850677, 18536.536586585342, 19157.521061973457, 5704.773473703153, 5706.315242170935, 5947.732352044147, 5949.613275137124, 5956.047032474805, 5780.826575202751, 5841.0, 5874.970625146868, 5884.058550631899, 5888.852778680524, 5576.498115169634, 5682.460166284196, 5858.0, 5858.8242352729485, 5862.06207006879, 5712.828615141552, 5733.512651424634, 5756.5682573807135, 5760.049591817345, 5760.971195144019, 5018.623603229772, 5096.51583099605, 5100.872478188038, 5222.399424066243, 5269.077911365534, 23402.063917443284, 23437.179698710464, 23519.4120146996, 23541.17605883803, 23674.881625591934, 2309.180241014449, 2342.4495243617907, 2378.096323397115, 2536.556102682042, 2836.858157092158, 14511.274436278143, 14847.925760371128, 14855.777163342558, 15019.474318398912, 15305.1582162981, 1858.256697321069, 1904.2002359009111, 1921.6156768646188, 1944.6888497840278, 1992.571597106629, 81353.0, 81832.0, 82125.0, 82694.58652706759, 83483.0, 10649.787004259872, 10726.839097413545, 10970.506327215295, 11118.777624447628, 11378.487968041458, 15356.308966096329, 15501.0, 15516.379344826306, 15518.456854010281, 15522.0, 7827.25641064098, 7869.291763741291, 8055.227849873018, 8200.302974247137, 8259.917400826034, 7565.773026809205, 7588.127365352944, 7673.232676732394, 7789.961050194713, 7910.011248593926, 6454.77408290717, 6471.9029214561815, 6480.870382592322, 6551.639659818756, 6555.3772391622715, 1920.6542822292122, 1972.8914909680104, 2007.2974458939254, 2009.4976255936017, 2017.5964807038358, 1001.979960400788, 1005.2561104782409, 1028.9588416463407, 1042.8487869259068, 1079.994600026995, 19248.80751192498, 20125.49686257855, 20191.394258172277, 20291.695624565644, 20485.0, 988.8170688422665, 1013.8175128476945, 1037.865077539915, 1043.2801367056707, 1077.8167711489066, 10256.641017564349, 11356.886431135748, 11456.0, 11477.942610286895, 11487.36819474937, 436313.0, 442591.0, 446758.0, 447286.0, 447364.0, 77908.22091779123, 79434.0, 79461.60269198618, 79494.602526987, 82639.5868020656, 989.6536212325773, 1006.9024763008356, 1034.250168627739, 1046.3721766939927, 1047.4553232319304, 16667.249973750968, 16991.235394407035, 17193.398231061852, 17640.206190721707, 17993.910030449762, 37779.0, 39214.607853922236, 39318.803405982784, 39401.60598393979, 40706.59293407028, 51787.48212517826, 51849.25959625225, 52293.215601766766, 52476.47523524716, 52802.679933001986, 8562.48625082497, 8580.399372044147, 8597.785055373415, 8622.65509379643, 8938.955305223431, 12326.568570100004, 12463.688407789878, 12584.622461326175, 12733.936330318289, 12969.740605187655, 11164.553417863195, 11479.8278025828, 11586.262060690964, 11639.5344186235, 12169.452374642986, 10170.491475426346, 10908.61819836302, 11166.888331116585, 11248.156388271076, 11747.236429632047, 6623.735050597922, 11362.318260904372, 11452.14108941816, 11627.941860290644, 11906.285622862655, 7398.482106252511, 7979.361651067785, 8392.160783921803, 8602.82794344097, 8710.869336959824, 11558.30650160993, 11751.236169648946, 11771.23486973344, 11850.0, 12130.33283169434], "value": 9261.414576064968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.3023597493332, 1459.7080583883223, 1494.0736743219206, 1621.1569983608524, 1785.1520527749328, 7881.330086942609, 8736.388452808305, 9027.684031058914, 9043.050479699627, 9288.489133097677, 9066.138716821892, 9157.679481218158, 9164.175224229817, 9166.358354915143, 9171.541422928844, 2256.289268880306, 2273.886305684709, 2276.7723227677266, 2278.5556816420803, 2280.1107568048474, 2198.16469741498, 2255.706758121442, 2291.793738563529, 2292.3925159832656, 2296.437372843647, 2246.764089770575, 2257.9435514112197, 2263.920762773303, 2266.444721043347, 2270.829687773415, 2176.978230217709, 2195.9121635134575, 2200.19692812124, 2203.7575866654656, 2206.8344874134423, 2190.835687323457, 2218.3455880515285, 2235.083615717564, 2242.618754811686, 2249.302716157996, 9024.684136055206, 9094.363394562382, 9096.77258068547, 9100.226480749145, 9102.86345704815, 5021.59827213822, 5182.455842136559, 5199.6360254782185, 5235.842924712265, 5243.501867322599, 2992.311768293283, 3141.198994256473, 3193.5209718542174, 3199.42410366134, 3202.7758056936023, 1071.5071067309048, 1073.5276478349501, 1075.725689949058, 1097.5609756097545, 1111.3220935229504, 12974.35128243584, 13023.0, 13027.934860325639, 13044.608661740163, 13087.0, 4208.978955105266, 4250.808713607895, 4402.911941761146, 4467.910641787146, 4489.910201795946, 10041.397516148909, 10045.0, 10047.045530674573, 10047.346922450017, 10053.547590358452, 5138.203578445347, 5140.948590514122, 5157.922631160535, 5158.09733296679, 5160.7935682573025, 4037.2329257440992, 4211.115665710174, 4289.227938971015, 4339.913201736011, 4862.586680132228, 3353.245519758084, 3749.887503374903, 3782.111203867089, 3801.9809900950872, 3804.2581696568905, 1083.090204228452, 1105.0883021507289, 1109.91120710343, 1110.3337997201616, 1123.6572845282267, 900.7793090692822, 953.6614501851743, 977.4379731654327, 984.6209209454269, 1004.0110491166196, 5920.904632642889, 5959.284885813643, 5981.820545383645, 6104.877902441926, 6278.183836101369, 452.65598145409723, 453.5328611530129, 455.4921262792029, 467.8596421073664, 469.82146784221777, 3947.921041579152, 3956.3669812829808, 3990.10222699896, 3999.440078389028, 4086.1010577672864, 10577.788444231071, 11370.20408571392, 11456.427178641035, 11460.312381257152, 11475.254108482923, 11194.944025279985, 11270.267432616854, 11290.0, 11309.604163854226, 11444.542218311175, 8230.341572674171, 8315.334773218248, 8364.0, 8378.245957863943, 8391.118932512121, 5683.72116273835, 5757.280339957505, 5805.854853628524, 5810.389909059657, 5986.161937328865, 10401.375917444977, 10519.105876000625, 10527.368357898551, 10537.683869483928, 10554.788904222027, 9236.445813251226, 10022.398656080659, 10461.320014199053, 10478.79042419132, 10790.136789057013, 7001.159860816734, 7452.552846829208, 7584.317411432998, 7653.693852245848, 7841.803954901173, 8258.380621453534, 8277.710280140167, 8329.916700832913, 8334.49993000422, 8444.619992100248, 7456.96271518639, 7521.7743467696055, 7536.472446928662, 7581.0, 7622.0, 7292.635368231673, 7382.298681625237, 7542.622868856645, 7579.734709285149, 7593.658285377282, 6717.630530320879, 6732.293109223657, 6740.966295168493, 6826.624535650587, 6839.658017099225, 4797.736124513185, 4859.635527335393, 4890.731009794353, 4966.329545511454, 5123.462036486116, 4687.437507499122, 4845.927311090266, 4968.2050871861775, 5065.696058236517, 5150.665206761549], "value": 4463.713034309907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9090697403655, 337.55611371047075, 344.78967829623934, 347.0525465479242, 350.353597612405, 5027.34644496215, 5174.922376164361, 5206.973965130173, 5218.739063046847, 5240.213967904811, 4995.900081998358, 5091.338126043609, 5120.436751957282, 5121.411037730662, 5122.718250496221, 4061.2689715851134, 4064.4919385076864, 4066.227416790815, 4068.369402742565, 4094.733842300241, 3837.0431080149187, 3886.6113388661192, 4096.651784598313, 4124.237016152007, 4142.0, 4044.5550989391145, 4047.7571345719202, 4055.3105971984833, 4078.4697989261504, 4092.1201941582553, 4080.204360149772, 4082.612151845585, 4086.5504794472436, 4088.3049881520215, 4105.507339119295, 3686.0600546860646, 3688.4098544232793, 3690.1328187876097, 3705.3515634763808, 3708.128589781399, 4894.804207831682, 4980.858230960685, 5024.497550244982, 5029.127571769717, 5042.4201216860165, 4681.250999840044, 4699.506551812045, 4709.0, 4713.387259656222, 4720.457147428056, 5361.463853614647, 5371.623986320959, 5373.516383525502, 5374.973125134388, 5414.7834086636485, 3735.6451137141926, 3884.436756670267, 3927.371620540728, 3929.9410508842107, 3942.8028598570245, 5576.776928922838, 5593.552515798727, 5604.887902241932, 5617.634853734494, 5619.606627536034, 4030.334994725896, 4031.9395209071886, 4055.6958228133008, 4067.3695577185586, 4080.714349995472, 3996.9200615987515, 4006.9181321043156, 4034.899127521777, 4063.7358571692744, 4107.863910766445, 4595.977020114878, 4606.792694328697, 4609.00906305146, 4611.746353950565, 4628.4445866496235, 5404.891902161935, 5430.755615997289, 5445.156000819879, 5479.0959491684225, 5483.232347471358, 1357.3484727330936, 1370.5198385743374, 1390.9095908765898, 1398.2868736944029, 1404.8339877901317, 890.6036813618007, 907.9150415253708, 924.426855349674, 928.8853375948888, 929.3328148214667, 4635.837745678885, 4661.86014419568, 4663.481719871299, 4686.601638860667, 4689.460712018162, 4903.705777653352, 4926.0, 4926.729029903389, 4928.102680467974, 4935.864751107266, 4410.170862905114, 4632.25883858581, 4641.002184530342, 4658.440987081572, 4659.254519276899, 2544.8727563621746, 2591.2614904752054, 2594.507043661736, 2597.882910348568, 2612.673415823022, 5029.748512574357, 5042.705568966112, 5043.798248070036, 5059.62052846038, 5065.493450654905, 4538.275455326954, 4906.607471402351, 4923.901521969612, 4974.477679843637, 4981.452040275567, 5078.847634570969, 5094.5669618082875, 5100.336956195671, 5103.948960510347, 5154.664946778447, 4957.677750946177, 4963.454020057863, 4979.477154898828, 5010.223415370623, 5012.899742005213, 4831.347768051268, 4876.829310974099, 4928.630352723489, 4950.183219768698, 5016.6237532184505, 5710.885782284248, 5721.6280941740315, 5724.398938111438, 5737.426257374229, 5833.562482813721, 3873.554541227682, 4035.273650742777, 4040.0, 4052.068024354474, 4053.0, 5230.0, 5513.58648101386, 5515.22786809855, 5521.585881058856, 5521.812810245817, 5401.864953376197, 5421.400686797326, 5427.0, 5432.429594892479, 5449.5640348772795, 5300.70846103468, 5351.170568561879, 5392.784288628568, 5439.184122381675, 5447.155690867922, 5379.973100134631, 5380.3274590676165, 5382.273393091882, 5383.757730902041, 5386.676799392049, 5444.713220447343, 5446.1558458439, 5452.809151679672, 5474.397816240131, 5477.3427188737605, 5087.880666253418, 5284.709340986129, 5298.178782288752, 5313.814016509404, 5334.226537152013], "value": 4030.936489500673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.4615692074024, 729.9708011679533, 769.127040808682, 770.8766597344422, 816.1573496104256, 15525.378984840607, 17322.653546929054, 17331.133443327846, 17339.219735111918, 17345.306187752507, 14770.409183632668, 14964.476243331459, 14991.100533967969, 15009.0, 15022.323995420205, 660.0890770736377, 673.7810211681199, 792.1998781230955, 816.2327412232482, 820.5774026376421, 782.765170448863, 810.7689308547066, 814.2020819596798, 821.2157389692829, 821.2485575698258, 842.8862103616025, 845.0619812008665, 845.1590667286029, 845.7251393297172, 845.8646616541355, 681.6285124607101, 835.3192148399036, 836.8451836410222, 836.9163083691612, 837.5937670229964, 515.7782153673919, 612.2347066167291, 625.5683578330983, 627.5293529852611, 627.9277883043417, 15353.15557644329, 15528.844711552965, 15547.0, 15548.533543993699, 15551.30019149141, 13785.310734463237, 13995.860041399557, 14241.359138838778, 14480.493182738554, 14620.780688289684, 12928.35358232094, 12983.221006739626, 12995.87004129956, 13068.150570212905, 13349.799753003712, 4339.240632889232, 4412.933805992912, 4417.779111044435, 4425.137098265839, 4441.666874984389, 80939.19060809375, 80990.19009809944, 81007.5949620254, 81151.0, 81407.18592814055, 11075.446227688582, 11153.832692509619, 11456.312621242752, 11595.942020289845, 11965.521379144911, 21417.78582214189, 21517.0, 21667.56664866694, 21717.565648687254, 21729.348119556438, 8316.584170791557, 8387.0, 8418.831623367498, 8667.653293868174, 8711.912880871238, 4584.541545845455, 4651.720896746206, 4757.333973243749, 4769.76151192439, 4990.850274491771, 3302.7688061835443, 3408.113890388467, 3411.2836304375865, 3411.522386865841, 3413.4026545354463, 577.3072313224064, 578.3811321885543, 583.8423625621143, 606.0333767640606, 607.0954278125649, 612.9938700612937, 658.973641054362, 667.9632620205936, 679.1646275081678, 727.31995584129, 8899.150277257013, 8987.955060224656, 9245.3528253023, 9277.953610231905, 9282.164605185566, 614.9600275982136, 639.7984634840011, 674.2717864706106, 676.235853485568, 702.2310569925922, 4178.477690288714, 4379.715318504287, 4465.598096171295, 4466.798994045275, 4467.15124126415, 66760.33239667639, 91495.54252228697, 114874.0, 129636.0, 130089.0, 107884.0, 110064.0, 111310.0, 111351.0, 112688.0, 76097.61951190208, 91162.0, 91844.0, 97750.51124744331, 98252.50873745585, 7991.0, 8034.317083048007, 8371.874421883798, 8496.150384961455, 8566.602436137024, 56523.43476565346, 56599.151012734015, 56684.0, 56989.31181699038, 59527.0, 75883.24116758762, 77849.61075194587, 84072.0, 84157.579212106, 85718.57140714256, 11362.886371136183, 11486.597969071043, 11615.88384116148, 11750.471228794895, 12022.458989345325, 12464.314462704639, 12575.182613130117, 12873.420696068511, 13255.80116298237, 13824.654383640489, 11868.584599538975, 11871.821922671339, 11909.702257443632, 11943.701407464883, 12058.216215945935, 11324.490397932277, 11423.714407139556, 11564.884351156717, 11679.182457227913, 11826.467808948446, 11179.441027948733, 11492.540298388305, 11832.0, 11868.82196767032, 11916.285022898654, 10023.498825058863, 10126.291159618757, 10201.183905287708, 10306.690799276033, 10484.907111144303, 10054.19566434669, 10287.435747024643, 10482.842757358494, 10511.94744026275, 10528.947355263175], "value": 7394.614631551521, "unit": "score"}], "name": "dromaeo_css", "value": 7075.361841176148, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 111.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 123.0, 163.0, 122.0, 124.0, 119.0, 119.0, 153.0, 127.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 161.0, 164.0, 160.0, 161.0, 159.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 112.0, 76.0, 76.0, 76.0, 76.0, 97.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 122.0, 83.0, 84.0, 84.0, 106.0, 83.0, 83.0, 110.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 50.0, 52.0, 54.0, 53.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 80.0, 85.0, 85.0, 88.0, 80.0, 88.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 140.0, 128.0, 139.0, 133.0, 131.0, 138.0, 170.0, 132.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 165.0, 167.0, 164.0, 173.0, 166.0, 163.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 75.0, 65.0, 66.0, 67.0, 66.0, 64.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1501.0, "alertThreshold": 2.0}]} 21:37:27 INFO - Return code: 0 21:37:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:37:27 INFO - # TBPL SUCCESS # 21:37:27 INFO - Running post-action listener: _resource_record_post_action 21:37:27 INFO - [mozharness: 2016-10-11 04:37:27.076886Z] Finished run-tests step (success) 21:37:27 INFO - Running post-run listener: _resource_record_post_run 21:37:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404877312; Read time: 8; Write time: 258236 21:37:27 INFO - TinderboxPrint: CPU usage
13.1% 21:37:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:37:27 INFO - TinderboxPrint: I/O write bytes / time
404,877,312 / 258,236 21:37:27 INFO - TinderboxPrint: CPU idle
8,285.2 (86.9%) 21:37:27 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 21:37:27 INFO - TinderboxPrint: Swap in / out
0 / 0 21:37:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114352128; Read time: 0; Write time: 67324 21:37:27 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289398784; Read time: 0; Write time: 190872 21:37:27 INFO - Running post-run listener: _upload_blobber_files 21:37:27 INFO - Blob upload gear active. 21:37:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:37:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:37:28 INFO - (blobuploader) - INFO - Open directory for files ... 21:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:28 INFO - (blobuploader) - INFO - Done attempting. 21:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:32 INFO - (blobuploader) - INFO - Done attempting. 21:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:33 INFO - (blobuploader) - INFO - Done attempting. 21:37:33 INFO - (blobuploader) - INFO - Iteration through files over. 21:37:33 INFO - Return code: 0 21:37:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:37:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:37:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d807ca82dc428218caa7a9f34de0a7197dc7e5550934094a05ba6811bdf678641e5593c97a663e074fc3d5074ca10cf073019123e4e790b7c48d7b90fa131d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc33018685bf4290fda6af32fe78cb4906340336b5d7124055ea290dba9a02eb66c9fb06a49c457973aa379dd780e582100cde175637a130400d0c207082ef7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c05ce1ed4f4c08f49a9673b936ec863f709033ac64b16f84361caa658411aa598d37abb37ae12ed9be4ee9181afd0c79ef941b7d0fbe3dd0e322a92544e455ca"} 21:37:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:37:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:37:33 INFO - Contents: 21:37:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d807ca82dc428218caa7a9f34de0a7197dc7e5550934094a05ba6811bdf678641e5593c97a663e074fc3d5074ca10cf073019123e4e790b7c48d7b90fa131d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc33018685bf4290fda6af32fe78cb4906340336b5d7124055ea290dba9a02eb66c9fb06a49c457973aa379dd780e582100cde175637a130400d0c207082ef7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c05ce1ed4f4c08f49a9673b936ec863f709033ac64b16f84361caa658411aa598d37abb37ae12ed9be4ee9181afd0c79ef941b7d0fbe3dd0e322a92544e455ca"} 21:37:33 INFO - Running post-run listener: copy_logs_to_upload_dir 21:37:33 INFO - Copying logs to upload dir... 21:37:33 INFO - mkdir: /builds/slave/test/build/upload/logs 21:37:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.908065 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-10 21:37:31.943555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:37:31.947153) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2d807ca82dc428218caa7a9f34de0a7197dc7e5550934094a05ba6811bdf678641e5593c97a663e074fc3d5074ca10cf073019123e4e790b7c48d7b90fa131d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc33018685bf4290fda6af32fe78cb4906340336b5d7124055ea290dba9a02eb66c9fb06a49c457973aa379dd780e582100cde175637a130400d0c207082ef7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c05ce1ed4f4c08f49a9673b936ec863f709033ac64b16f84361caa658411aa598d37abb37ae12ed9be4ee9181afd0c79ef941b7d0fbe3dd0e322a92544e455ca"} build_url:https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/fr_7H4lRSIa3vpdck35LMQ/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/sha512/b2d807ca82dc428218caa7a9f34de0a7197dc7e5550934094a05ba6811bdf678641e5593c97a663e074fc3d5074ca10cf073019123e4e790b7c48d7b90fa131d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc33018685bf4290fda6af32fe78cb4906340336b5d7124055ea290dba9a02eb66c9fb06a49c457973aa379dd780e582100cde175637a130400d0c207082ef7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c05ce1ed4f4c08f49a9673b936ec863f709033ac64b16f84361caa658411aa598d37abb37ae12ed9be4ee9181afd0c79ef941b7d0fbe3dd0e322a92544e455ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:37:31.972942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:37:31.973265) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476158586.445937-1636100723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:37:32.055591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:37:32.055910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:37:32.056204) ========= ========= Total master_lag: 0.16 =========