builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1468068840.73 results: success (0) buildid: 20160709030233 builduid: ab494e5741ee4958a59fe49d666c5b72 revision: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.730819) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.731233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.731527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.779859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.780131) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 05:54:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-07-09 05:54:01 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.939459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.939787) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.990443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:00.990833) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bbb29a9b88dd680dbb59577cbe4dc6e58d117100 --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 bbb29a9b88dd680dbb59577cbe4dc6e58d117100 --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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 05:54:01,404 truncating revision to first 12 chars 2016-07-09 05:54:01,404 Setting DEBUG logging. 2016-07-09 05:54:01,404 attempt 1/10 2016-07-09 05:54:01,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bbb29a9b88dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 05:54:01,846 unpacking tar archive at: mozilla-central-bbb29a9b88dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:01.785268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:01.785563) ========= script_repo_revision: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:01.785939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:01.786229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 05:54:01.806497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-09 05:54:01.806795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:02 INFO - MultiFileLogger online at 20160709 05:54:02 in /builds/slave/test 05:54:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:02 INFO - {'append_to_log': False, 05:54:02 INFO - 'base_work_dir': '/builds/slave/test', 05:54:02 INFO - 'blob_upload_branch': 'Firefox', 05:54:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:02 INFO - 'branch': 'Firefox', 05:54:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:02 INFO - 'config_files': ('talos/linux_config.py',), 05:54:02 INFO - 'default_actions': ('clobber', 05:54:02 INFO - 'read-buildbot-config', 05:54:02 INFO - 'download-and-extract', 05:54:02 INFO - 'populate-webroot', 05:54:02 INFO - 'create-virtualenv', 05:54:02 INFO - 'install', 05:54:02 INFO - 'run-tests'), 05:54:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:02 INFO - 'download_minidump_stackwalk': True, 05:54:02 INFO - 'download_symbols': 'ondemand', 05:54:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:02 INFO - 'installer_path': 'installer.exe', 05:54:02 INFO - 'log_level': 'info', 05:54:02 INFO - 'log_name': 'talos', 05:54:02 INFO - 'log_to_console': True, 05:54:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:02 INFO - 'opt_config_files': (), 05:54:02 INFO - 'pip_index': False, 05:54:02 INFO - 'sps_profile': False, 05:54:02 INFO - 'sps_profile_interval': 0, 05:54:02 INFO - 'suite': 'dromaeojs-e10s', 05:54:02 INFO - 'system_bits': '32', 05:54:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:02 INFO - 'title': 'talos-linux64-ix-013', 05:54:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:02 INFO - 'use_talos_json': True, 05:54:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:02 INFO - 'work_dir': 'build'} 05:54:02 INFO - ##### 05:54:02 INFO - ##### Running clobber step. 05:54:02 INFO - ##### 05:54:02 INFO - Running pre-action listener: _resource_record_pre_action 05:54:02 INFO - Running main action method: clobber 05:54:02 INFO - rmtree: /builds/slave/test/build 05:54:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:03 INFO - Running post-action listener: _resource_record_post_action 05:54:03 INFO - ##### 05:54:03 INFO - ##### Finished clobber step (success) 05:54:03 INFO - ##### 05:54:03 INFO - ##### 05:54:03 INFO - ##### Running read-buildbot-config step. 05:54:03 INFO - ##### 05:54:03 INFO - Running pre-action listener: _resource_record_pre_action 05:54:03 INFO - Running main action method: read_buildbot_config 05:54:03 INFO - Using buildbot properties: 05:54:03 INFO - { 05:54:03 INFO - "project": "", 05:54:03 INFO - "product": "firefox", 05:54:03 INFO - "script_repo_revision": "production", 05:54:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:54:03 INFO - "repository": "", 05:54:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:54:03 INFO - "buildid": "20160709030233", 05:54:03 INFO - "stage_platform": "linux64-pgo", 05:54:03 INFO - "basedir": "/builds/slave/test", 05:54:03 INFO - "nightly_build": "True", 05:54:03 INFO - "buildnumber": 286, 05:54:03 INFO - "slavename": "talos-linux64-ix-013", 05:54:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:54:03 INFO - "platform": "ubuntu64_hw", 05:54:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:03 INFO - "branch": "mozilla-central", 05:54:03 INFO - "repo_path": "mozilla-central", 05:54:03 INFO - "revision": "bbb29a9b88dd680dbb59577cbe4dc6e58d117100", 05:54:03 INFO - "pgo_build": "True", 05:54:03 INFO - "builduid": "ab494e5741ee4958a59fe49d666c5b72", 05:54:03 INFO - "slavebuilddir": "test" 05:54:03 INFO - } 05:54:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:54:03 INFO - Running post-action listener: _resource_record_post_action 05:54:03 INFO - ##### 05:54:03 INFO - ##### Finished read-buildbot-config step (success) 05:54:03 INFO - ##### 05:54:03 INFO - ##### 05:54:03 INFO - ##### Running download-and-extract step. 05:54:03 INFO - ##### 05:54:03 INFO - Running pre-action listener: _resource_record_pre_action 05:54:03 INFO - Running main action method: download_and_extract 05:54:03 INFO - mkdir: /builds/slave/test/build/tests 05:54:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:03 INFO - https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:15 INFO - Downloaded 1361 bytes. 05:54:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:54:15 INFO - Using the following test package requirements: 05:54:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'jsshell-linux-x86_64.zip'], 05:54:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:15 INFO - https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:31 INFO - Downloaded 24304462 bytes. 05:54:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:32 INFO - Return code: 0 05:54:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:32 INFO - https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:37 INFO - Downloaded 24304462 bytes. 05:54:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:39 INFO - Return code: 0 05:54:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:39 INFO - https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:40 INFO - Downloaded 14403333 bytes. 05:54:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:54:40 INFO - Return code: 0 05:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:40 INFO - https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:42 INFO - Downloaded 60429378 bytes. 05:54:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:42 INFO - mkdir: /builds/slave/test/properties 05:54:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:42 INFO - Contents: 05:54:42 INFO - build_url:https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:54:43 INFO - Running post-action listener: _resource_record_post_action 05:54:43 INFO - Running post-action listener: set_extra_try_arguments 05:54:43 INFO - ##### 05:54:43 INFO - ##### Finished download-and-extract step (success) 05:54:43 INFO - ##### 05:54:43 INFO - ##### 05:54:43 INFO - ##### Running populate-webroot step. 05:54:43 INFO - ##### 05:54:43 INFO - Running pre-action listener: _resource_record_pre_action 05:54:43 INFO - Running main action method: populate_webroot 05:54:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:43 INFO - '--tppagecycles', 05:54:43 INFO - '7'], 05:54:43 INFO - 'tests': ['tsvgm']}}, 05:54:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['damp', 'tps']}, 05:54:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'tests': ['damp', 'tps']}, 05:54:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['dromaeo_dom']}, 05:54:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['basic_compositor_video']}, 05:54:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['a11yr', 05:54:43 INFO - 'ts_paint', 05:54:43 INFO - 'tpaint', 05:54:43 INFO - 'sessionrestore', 05:54:43 INFO - 'sessionrestore_no_auto_restore', 05:54:43 INFO - 'tabpaint']}, 05:54:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['tsvgx', 05:54:43 INFO - 'tsvgr_opacity', 05:54:43 INFO - 'tart', 05:54:43 INFO - 'tscrollx', 05:54:43 INFO - 'cart']}, 05:54:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:43 INFO - 'tsvgr_opacity', 05:54:43 INFO - 'tart', 05:54:43 INFO - 'tscrollx', 05:54:43 INFO - 'cart']}, 05:54:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'talos_options': ['--disable-e10s'], 05:54:43 INFO - 'tests': ['tp5o']}, 05:54:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'tests': ['tp5o']}, 05:54:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'talos_options': ['--disable-e10s', 05:54:43 INFO - '--xperf_path', 05:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:43 INFO - 'tests': ['tp5n']}, 05:54:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:43 INFO - 'talos_options': ['--xperf_path', 05:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:43 INFO - 'tests': ['tp5n']}}, 05:54:43 INFO - 'talos.zip': {'path': '', 05:54:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:43 INFO - Running post-action listener: _resource_record_post_action 05:54:43 INFO - ##### 05:54:43 INFO - ##### Finished populate-webroot step (success) 05:54:43 INFO - ##### 05:54:43 INFO - ##### 05:54:43 INFO - ##### Running create-virtualenv step. 05:54:43 INFO - ##### 05:54:43 INFO - Running pre-action listener: _resource_record_pre_action 05:54:43 INFO - Running main action method: create_virtualenv 05:54:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:43 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 05:54:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:43 INFO - Using real prefix '/usr' 05:54:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:45 INFO - Installing pip.................done. 05:54:45 INFO - Return code: 0 05:54:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:45 INFO - Using env: {'DISPLAY': ':0', 05:54:45 INFO - 'HOME': '/home/cltbld', 05:54:45 INFO - 'LANG': 'en_US.UTF-8', 05:54:45 INFO - 'LANGUAGE': 'en_US:en', 05:54:45 INFO - 'LOGNAME': 'cltbld', 05:54:45 INFO - 'MAIL': '/var/mail/cltbld', 05:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:45 INFO - 'MOZ_NO_REMOTE': '1', 05:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:45 INFO - 'NO_EM_RESTART': '1', 05:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:45 INFO - 'PWD': '/builds/slave/test', 05:54:45 INFO - 'SHELL': '/bin/bash', 05:54:45 INFO - 'SHLVL': '1', 05:54:45 INFO - 'TERM': 'linux', 05:54:45 INFO - 'TMOUT': '86400', 05:54:45 INFO - 'USER': 'cltbld', 05:54:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:46 INFO - '_': '/tools/buildbot/bin/python'} 05:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:46 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 05:54:46 INFO - Cleaning up... 05:54:46 INFO - Return code: 0 05:54:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:46 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:46 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 05:54:46 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 05:54:46 INFO - Using env: {'DISPLAY': ':0', 05:54:46 INFO - 'HOME': '/home/cltbld', 05:54:46 INFO - 'LANG': 'en_US.UTF-8', 05:54:46 INFO - 'LANGUAGE': 'en_US:en', 05:54:46 INFO - 'LOGNAME': 'cltbld', 05:54:46 INFO - 'MAIL': '/var/mail/cltbld', 05:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:46 INFO - 'MOZ_NO_REMOTE': '1', 05:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:46 INFO - 'NO_EM_RESTART': '1', 05:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:46 INFO - 'PWD': '/builds/slave/test', 05:54:46 INFO - 'SHELL': '/bin/bash', 05:54:46 INFO - 'SHLVL': '1', 05:54:46 INFO - 'TERM': 'linux', 05:54:46 INFO - 'TMOUT': '86400', 05:54:46 INFO - 'USER': 'cltbld', 05:54:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:46 INFO - '_': '/tools/buildbot/bin/python'} 05:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:46 INFO - Downloading/unpacking psutil>=3.1.1 05:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:48 INFO - Installing collected packages: psutil 05:54:48 INFO - Running setup.py install for psutil 05:54:48 INFO - building 'psutil._psutil_linux' extension 05:54:48 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 05:54:48 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 05:54:48 INFO - building 'psutil._psutil_posix' extension 05:54:48 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 05:54:48 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 05:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:48 INFO - Successfully installed psutil 05:54:48 INFO - Cleaning up... 05:54:48 INFO - Return code: 0 05:54:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:48 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 05:54:48 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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:51 INFO - Installing collected packages: mozsystemmonitor 05:54:51 INFO - Running setup.py install for mozsystemmonitor 05:54:51 INFO - Successfully installed mozsystemmonitor 05:54:51 INFO - Cleaning up... 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:51 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 05:54:51 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 05:54:51 INFO - Using env: {'DISPLAY': ':0', 05:54:51 INFO - 'HOME': '/home/cltbld', 05:54:51 INFO - 'LANG': 'en_US.UTF-8', 05:54:51 INFO - 'LANGUAGE': 'en_US:en', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MAIL': '/var/mail/cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SHLVL': '1', 05:54:51 INFO - 'TERM': 'linux', 05:54:51 INFO - 'TMOUT': '86400', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - '_': '/tools/buildbot/bin/python'} 05:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:53 INFO - warning: no files found matching '*.txt' 05:54:53 INFO - no previously-included directories found matching 'build' 05:54:53 INFO - no previously-included directories found matching 'dist' 05:54:53 INFO - no previously-included directories found matching '.git*' 05:54:53 INFO - Installing collected packages: jsonschema, functools32 05:54:53 INFO - Running setup.py install for functools32 05:54:53 INFO - warning: no files found matching '*.txt' 05:54:53 INFO - no previously-included directories found matching 'build' 05:54:53 INFO - no previously-included directories found matching 'dist' 05:54:53 INFO - no previously-included directories found matching '.git*' 05:54:53 INFO - Successfully installed jsonschema functools32 05:54:53 INFO - Cleaning up... 05:54:53 INFO - Return code: 0 05:54:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:53 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:53 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 05:54:53 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 05:54:53 INFO - Using env: {'DISPLAY': ':0', 05:54:53 INFO - 'HOME': '/home/cltbld', 05:54:53 INFO - 'LANG': 'en_US.UTF-8', 05:54:53 INFO - 'LANGUAGE': 'en_US:en', 05:54:53 INFO - 'LOGNAME': 'cltbld', 05:54:53 INFO - 'MAIL': '/var/mail/cltbld', 05:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:53 INFO - 'MOZ_NO_REMOTE': '1', 05:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:53 INFO - 'NO_EM_RESTART': '1', 05:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:53 INFO - 'PWD': '/builds/slave/test', 05:54:53 INFO - 'SHELL': '/bin/bash', 05:54:53 INFO - 'SHLVL': '1', 05:54:53 INFO - 'TERM': 'linux', 05:54:53 INFO - 'TMOUT': '86400', 05:54:53 INFO - 'USER': 'cltbld', 05:54:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:53 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - Downloading docopt-0.6.1.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:56 INFO - Running setup.py install for blobuploader 05:54:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:56 INFO - Running setup.py install for requests 05:54:57 INFO - Running setup.py install for docopt 05:54:57 INFO - Successfully installed blobuploader requests docopt 05:54:57 INFO - Cleaning up... 05:54:57 INFO - Return code: 0 05:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:54:57 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 05:54:57 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 05:54:57 INFO - Using env: {'DISPLAY': ':0', 05:54:57 INFO - 'HOME': '/home/cltbld', 05:54:57 INFO - 'LANG': 'en_US.UTF-8', 05:54:57 INFO - 'LANGUAGE': 'en_US:en', 05:54:57 INFO - 'LOGNAME': 'cltbld', 05:54:57 INFO - 'MAIL': '/var/mail/cltbld', 05:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:57 INFO - 'MOZ_NO_REMOTE': '1', 05:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:57 INFO - 'NO_EM_RESTART': '1', 05:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:57 INFO - 'PWD': '/builds/slave/test', 05:54:57 INFO - 'SHELL': '/bin/bash', 05:54:57 INFO - 'SHLVL': '1', 05:54:57 INFO - 'TERM': 'linux', 05:54:57 INFO - 'TMOUT': '86400', 05:54:57 INFO - 'USER': 'cltbld', 05:54:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:57 INFO - '_': '/tools/buildbot/bin/python'} 05:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 INFO - Running setup.py (path:/tmp/pip-6851DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 INFO - Running setup.py (path:/tmp/pip-UbRvfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:57 INFO - Running setup.py (path:/tmp/pip-egRfQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:57 INFO - Running setup.py (path:/tmp/pip-P5sXKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:57 INFO - Running setup.py (path:/tmp/pip-2D5Y1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:57 INFO - Running setup.py (path:/tmp/pip-VYMMLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:57 INFO - Running setup.py (path:/tmp/pip-W_eqT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 INFO - Running setup.py (path:/tmp/pip-dSb5Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:58 INFO - Running setup.py (path:/tmp/pip-ePWgb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:58 INFO - Running setup.py (path:/tmp/pip-gXYS9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 INFO - Running setup.py (path:/tmp/pip-O82RF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 INFO - Running setup.py (path:/tmp/pip-2WAB9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:58 INFO - Running setup.py (path:/tmp/pip-8RmM0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:58 INFO - Running setup.py (path:/tmp/pip-3EIbH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:58 INFO - Running setup.py (path:/tmp/pip-9dwcLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:58 INFO - Running setup.py (path:/tmp/pip-KMLxcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:58 INFO - Running setup.py (path:/tmp/pip-VYU9Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:58 INFO - Running setup.py install for manifestparser 05:54:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:58 INFO - Running setup.py install for mozcrash 05:54:58 INFO - Running setup.py install for mozdebug 05:54:59 INFO - Running setup.py install for mozdevice 05:54:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozfile 05:54:59 INFO - Running setup.py install for mozhttpd 05:54:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozinfo 05:54:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozInstall 05:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozleak 05:54:59 INFO - Running setup.py install for mozlog 05:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for moznetwork 05:54:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:59 INFO - Running setup.py install for mozprocess 05:55:00 INFO - Running setup.py install for mozprofile 05:55:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for mozrunner 05:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Running setup.py install for mozscreenshot 05:55:00 INFO - Running setup.py install for moztest 05:55:00 INFO - Running setup.py install for mozversion 05:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:00 INFO - Cleaning up... 05:55:00 INFO - Return code: 0 05:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:00 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:55:00 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 05:55:00 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 05:55:00 INFO - Using env: {'DISPLAY': ':0', 05:55:00 INFO - 'HOME': '/home/cltbld', 05:55:00 INFO - 'LANG': 'en_US.UTF-8', 05:55:00 INFO - 'LANGUAGE': 'en_US:en', 05:55:00 INFO - 'LOGNAME': 'cltbld', 05:55:00 INFO - 'MAIL': '/var/mail/cltbld', 05:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:00 INFO - 'MOZ_NO_REMOTE': '1', 05:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:00 INFO - 'NO_EM_RESTART': '1', 05:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:00 INFO - 'PWD': '/builds/slave/test', 05:55:00 INFO - 'SHELL': '/bin/bash', 05:55:00 INFO - 'SHLVL': '1', 05:55:00 INFO - 'TERM': 'linux', 05:55:00 INFO - 'TMOUT': '86400', 05:55:00 INFO - 'USER': 'cltbld', 05:55:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:00 INFO - '_': '/tools/buildbot/bin/python'} 05:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 INFO - Running setup.py (path:/tmp/pip-TSwpVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 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)) 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 INFO - Running setup.py (path:/tmp/pip-klYcgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 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)) 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:00 INFO - Running setup.py (path:/tmp/pip-4OBZJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:01 INFO - Running setup.py (path:/tmp/pip-v9Tb_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:01 INFO - Running setup.py (path:/tmp/pip-8Vo54Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:01 INFO - Running setup.py (path:/tmp/pip-ouy8Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:01 INFO - Running setup.py (path:/tmp/pip-gUpK2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:01 INFO - Running setup.py (path:/tmp/pip-VTqycX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:01 INFO - Running setup.py (path:/tmp/pip-Z3n6hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:01 INFO - Running setup.py (path:/tmp/pip-HZCuBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 INFO - Running setup.py (path:/tmp/pip-LsV91V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 INFO - Running setup.py (path:/tmp/pip-JQLlq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 INFO - Running setup.py (path:/tmp/pip-Kzt9C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Running setup.py (path:/tmp/pip-g8if32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 INFO - Running setup.py (path:/tmp/pip-bq5XXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:01 INFO - Running setup.py (path:/tmp/pip-KpxvT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:01 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)) 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:01 INFO - Running setup.py (path:/tmp/pip-Zp97AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 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)) 05:55:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:03 INFO - Downloading blessings-1.6.tar.gz 05:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:04 INFO - Installing collected packages: blessings 05:55:04 INFO - Running setup.py install for blessings 05:55:04 INFO - Successfully installed blessings 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:04 INFO - Reading from file tmpfile_stdout 05:55:04 INFO - Current package versions: 05:55:04 INFO - argparse == 1.2.1 05:55:04 INFO - blessings == 1.6 05:55:04 INFO - blobuploader == 1.2.4 05:55:04 INFO - docopt == 0.6.1 05:55:04 INFO - functools32 == 3.2.3-2 05:55:04 INFO - jsonschema == 2.5.1 05:55:04 INFO - manifestparser == 1.1 05:55:04 INFO - mozInstall == 1.12 05:55:04 INFO - mozcrash == 0.17 05:55:04 INFO - mozdebug == 0.1 05:55:04 INFO - mozdevice == 0.48 05:55:04 INFO - mozfile == 1.2 05:55:04 INFO - mozhttpd == 0.7 05:55:04 INFO - mozinfo == 0.9 05:55:04 INFO - mozleak == 0.1 05:55:04 INFO - mozlog == 3.2 05:55:04 INFO - moznetwork == 0.27 05:55:04 INFO - mozprocess == 0.23 05:55:04 INFO - mozprofile == 0.28 05:55:04 INFO - mozrunner == 6.12 05:55:04 INFO - mozscreenshot == 0.1 05:55:04 INFO - mozsystemmonitor == 0.3 05:55:04 INFO - moztest == 0.7 05:55:04 INFO - mozversion == 1.4 05:55:04 INFO - psutil == 3.1.1 05:55:04 INFO - requests == 1.2.3 05:55:04 INFO - wsgiref == 0.1.2 05:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:55:04 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 05:55:04 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 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 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 0x2016030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', '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 05:55:04 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 05:55:04 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 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Running post-action listener: _resource_record_post_action 05:55:04 INFO - Running post-action listener: _start_resource_monitoring 05:55:04 INFO - Starting resource monitoring. 05:55:04 INFO - ##### 05:55:04 INFO - ##### Finished create-virtualenv step (success) 05:55:04 INFO - ##### 05:55:04 INFO - ##### 05:55:04 INFO - ##### Running install step. 05:55:04 INFO - ##### 05:55:04 INFO - Running pre-action listener: _resource_record_pre_action 05:55:04 INFO - Running main action method: install 05:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:05 INFO - Reading from file tmpfile_stdout 05:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:05 INFO - Reading from file tmpfile_stdout 05:55:05 INFO - Output received: 05:55:05 INFO - Usage: mozinstall [options] installer 05:55:05 INFO - Options: 05:55:05 INFO - -h, --help show this help message and exit 05:55:05 INFO - -d DEST, --destination=DEST 05:55:05 INFO - Directory to install application into. [default: 05:55:05 INFO - "/builds/slave/test"] 05:55:05 INFO - --app=APP Application being installed. [default: firefox] 05:55:05 INFO - mkdir: /builds/slave/test/build/application 05:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:22 INFO - Reading from file tmpfile_stdout 05:55:22 INFO - Output received: 05:55:22 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:22 INFO - Running post-action listener: _resource_record_post_action 05:55:22 INFO - ##### 05:55:22 INFO - ##### Finished install step (success) 05:55:22 INFO - ##### 05:55:22 INFO - ##### 05:55:22 INFO - ##### Running run-tests step. 05:55:22 INFO - ##### 05:55:22 INFO - Running pre-action listener: _resource_record_pre_action 05:55:22 INFO - Running main action method: run_tests 05:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:22 INFO - Python 2.7.3 05:55:22 INFO - Return code: 0 05:55:22 INFO - grabbing minidump binary from tooltool 05:55:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:22 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 0x22d53b0>, '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 0x22d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:22 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 05:55:22 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 05:55:22 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 05:55:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:22 INFO - Return code: 0 05:55:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:55:22 INFO - Using env: {'DISPLAY': ':0', 05:55:22 INFO - 'HOME': '/home/cltbld', 05:55:22 INFO - 'LANG': 'en_US.UTF-8', 05:55:22 INFO - 'LANGUAGE': 'en_US:en', 05:55:22 INFO - 'LOGNAME': 'cltbld', 05:55:22 INFO - 'MAIL': '/var/mail/cltbld', 05:55:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:22 INFO - 'MOZ_NO_REMOTE': '1', 05:55:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:22 INFO - 'NO_EM_RESTART': '1', 05:55:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:22 INFO - 'PWD': '/builds/slave/test', 05:55:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:22 INFO - 'SHELL': '/bin/bash', 05:55:22 INFO - 'SHLVL': '1', 05:55:22 INFO - 'TERM': 'linux', 05:55:22 INFO - 'TMOUT': '86400', 05:55:22 INFO - 'USER': 'cltbld', 05:55:22 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302', 05:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:22 INFO - '_': '/tools/buildbot/bin/python'} 05:55:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:55:22 INFO - mozversion application_buildid: 20160709030233 05:55:22 INFO - mozversion application_changeset: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 05:55:22 INFO - mozversion application_display_name: Nightly 05:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:22 INFO - mozversion application_name: Firefox 05:55:22 INFO - mozversion application_remotingname: firefox 05:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:22 INFO - mozversion application_vendor: Mozilla 05:55:22 INFO - mozversion application_version: 50.0a1 05:55:22 INFO - mozversion platform_buildid: 20160709030233 05:55:22 INFO - mozversion platform_changeset: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 05:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:22 INFO - mozversion platform_version: 50.0a1 05:55:22 INFO - using testdate: 1468068922 05:55:22 INFO - actual date: 1468068922 05:55:22 INFO - starting webserver on 'localhost:36837' 05:55:22 INFO - SUITE-START | Running 2 tests 05:55:22 INFO - TEST-START | dromaeo_css 05:55:22 INFO - operating with platform_type : linux_ 05:55:22 INFO - Initialising browser for dromaeo_css test... 05:55:22 INFO - TEST-INFO | started process 9704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5R5JVT/profile http://localhost:36837/getInfo.html) 05:55:27 INFO - PROCESS | 9704 | __metrics Screen width/height:1600/1200 05:55:27 INFO - PROCESS | 9704 | colorDepth:24 05:55:27 INFO - PROCESS | 9704 | Browser inner width/height: 1024/697 05:55:27 INFO - PROCESS | 9704 | __metrics 05:55:28 ERROR - PROCESS | 9704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 05:55:29 INFO - TEST-INFO | 9704: exit 0 05:55:29 INFO - Browser initialized. 05:55:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:29 INFO - TEST-INFO | started process 9827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5R5JVT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:40 INFO - PROCESS | 9827 | RSS: Main: 167309312 05:55:40 INFO - PROCESS | 9827 | 05:56:30 INFO - PROCESS | 9827 | 1468068990464 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] 05:58:38 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36837/tests/dromaeo/cssquery-ext.html) 05:58:39 INFO - PROCESS | 9827 | RSS: Main: 170659840 05:58:39 INFO - PROCESS | 9827 | 06:01:41 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-ext.html (next: http://localhost:36837/tests/dromaeo/cssquery-jquery.html) 06:01:42 INFO - PROCESS | 9827 | RSS: Main: 167809024 06:01:42 INFO - PROCESS | 9827 | 06:04:44 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36837/tests/dromaeo/cssquery-mootools.html) 06:04:45 INFO - PROCESS | 9827 | RSS: Main: 171638784 06:04:45 INFO - PROCESS | 9827 | 06:07:46 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36837/tests/dromaeo/cssquery-prototype.html) 06:07:47 INFO - PROCESS | 9827 | RSS: Main: 166776832 06:07:47 INFO - PROCESS | 9827 | 06:10:50 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36837/tests/dromaeo/cssquery-yui.html) 06:10:50 INFO - PROCESS | 9827 | RSS: Main: 168800256 06:10:50 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | Cycle 1(1): loaded http://localhost:36837/tests/dromaeo/cssquery-yui.html (next: http://localhost:36837/tests/dromaeo/cssquery-dojo.html) 06:13:53 INFO - PROCESS | 9827 | RSS: Main: 169857024 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | __start_tp_report 06:13:53 INFO - PROCESS | 9827 | _x_x_mozilla_page_load 06:13:53 INFO - PROCESS | 9827 | _x_x_mozilla_page_load_details 06:13:53 INFO - PROCESS | 9827 | |i|pagename|runs| 06:13:53 INFO - PROCESS | 9827 | |0;dojo.html;3030.969690303097;3066.815991040536;3089.922751931201;3104.4412005838954;3104.829234392109;5344.305240318758;5423.511883930445;5452.0458919689045;5465.180222966557;5485.725713714318;5328.8401347959525;5351.331083614548;5395.487428694278;5410.8917821643545;5490.039243132456;4808.663393562452;4826.638002149844;4843.443004054526;4948.331975183341;4969.130402179622;4820.469748327699;5067.138586440314;5109.080365534202;5113.079645663797;5117.360329958755;4830.541098595628;4883.389576302962;5005.674631148963;5011.924821127686;5087.262346959688;4929.433115191727;4939.407271127452;4958.3306253655655;4960.503949605047;4970.254461830718;4902.142125128124;4903.436104847952;4907.11671899058;4928.43323017854;4959.876003099916;5185.61107916904;5339.199120131972;5405.351357837085;5416.9729151353995;5422.891542169174;5843.5325173985975;5845.473907348359;5851.502622277111;5855.941440585582;5888.617239879437;5893.911591326134;5897.115432685088;5898.852528686817;5918.289805223358;5936;5303.496167864047;5363.302770639831;5385.676859388449;5392.676439413648;5419.485148910847;5885.499732522783;5917.615355001911;5930.406959304121;5932.940670593325;5954.791582294599;5474.479924407175;5672.347680016851;5673.149027645886;5677.120046392815;5681.57388195887;5573.804916827973;5791.449812267828;5816.534677225812;5857.326407463111;5886.175935369051;5652.406497317805;5698.8290351289525;5752.165935939265;5753.8561535961935;5810.82567522975;5779.393163717833;5803.071508558694;5833.037548804485;5893.233879595625;5911.172435858984;4322.113966636832;4365.519792822787;4388.385626012297;4440.511543730187;4440.955590444119;3922.7057970652313;3931.76409415436;3936.0159960009996;3960.5247370315747;3975.6421922027157;5479.205515200274;5501.394846566875;5513.58648101394;5550;5584.832455026356;5784.623999440023;5815.069588865761;5819.592628516048;5843.970780146157;5851.268591426072;5540.612157148961;5549.889002220014;5610.579206559524;5613;5616.66300022;5074.517920797518;5078.238264260317;5080.212567052113;5102.897942041139;5126.615503837227;5821.970890145522;6066.636001839904;6081.148639190517;6094.725737341831;6128.842374115807;5869.970650146722;5874.206982057539;5922.466977972003;5925.970370148121;5966.701664916737;6039.849003774765;6106.2061931948565;6107.053406721965;6129.448349648553;6139.6009259398;5552.750126244409;5566.721663916707;5570.080936645408;5602.747876345656;5618.494335509824;5723.599348045597;5731.512821410227;5755.165501002415;5765.365809761007;5780.5953583248765;5560.888782224252;5567.220589117445;5631.915521267102;5637.746301416528;5645.379008309001;5383.434739352469;5653.971730141323;5660.915086273627;5660.971695141498;5674.4892959633835;5641.238432811518;5650.124230744241;5675.290588676416;5676.68778217202;5688.203651488712;5566.666000039849;5729.169270455844;5738.540916726568;5741.5119714824705;5743.971280143573;5507.339119305709;5531.8893622126525;5534.916976245279;5575.2473416088305;5603.3836278008575 06:13:53 INFO - PROCESS | 9827 | |1;ext.html;553.1927261453802;586.8855573163233;591.9230500034995;611.1321922869527;632.2697284636241;38752.41871371928;43552.128957420835;43557;43559;43703.344449833196;42052.579474205246;42667.786661066726;42777.35833962493;42797;42866.7856660717;8775.210231079218;8866.822663546725;8938.329625278131;8942.329325300596;8964.372493925428;8850.601722922453;8872.778180545474;8908.910910890905;8910.554472276393;8912.688055918044;8945.776355591097;8958.148975847284;8996.19034286914;8997.145271199226;9039.909600903973;8840.115988401141;8936.329775266848;8937.195652391316;8938.64245430182;8970.41692289999;8700.825983480296;8864.202221800004;8872.512011839346;8897.288216942628;8918.375713700043;41823.37264941028;42234;42398.788006059774;42420.78789606032;42457.78771106156;3118.3451475190236;3221.468457704476;3252.9512057319157;3265.8203798791055;3608.1340478285283;32193.51709724356;32638.836805816056;32994.6700532994;33734.493982590284;34130.82934585311;4318.762468064255;4353;4402.3176407656865;4454.309582014793;4601.171789077965;374770;378049.42678725795;379724.99999999726;380202;380526;57543.42456575464;58038;58148.418515815145;58287.708561457766;58340.416595834344;35943.4608480873;36787;36850.447243291375;38493.230135397134;61418;16907.746383804253;17055.317787288368;17075.573110672332;17095.401660941807;17128.14359282031;12958.157719748186;13043.739125217633;13073.477060917647;13131.212127272394;13163.47346106145;19523.926184060012;19561.804381955997;19586.84544700082;19690.60618787616;19747.111379987648;7083.468739844532;7166.570005799668;7176.856462870818;7285.235050319746;7379.704811807467;961.7739831139677;970.9368891022061;1021.8058568871891;1072.6406653770919;1094.3379255550437;30389.240268993453;32777.3444531108;32909.341813163606;33251.5012274816;33425.33149337048;1073.270176280137;1087.472575800736;1132.7451323452322;1184.490669012333;1211.5759484180467;16521.421750238685;16971.575710607085;16991.49025529236;17006.89091217321;17202.483925482255;571875.1093667991;578308;579215;580854;581956;59978.700106499185;60062;60340.396596034356;60645;60802.39197608056;1268.1693490763564;1303.5958852755675;1317.7693903567028;1321.953731619408;1324.5165514587106;31045.379092417574;31843.522347165275;32068.67931320657;32114.19714507156;32447.837760811046;51044.74477627588;51095.233571495715;51790.223146652075;51850.740746296025;51855.22217166821;483206.583967092;488051;488518;488957;489877;28023.439531209668;28298.71701283043;28510;28579.571306430003;28689.28276793097;45807.54192458033;48580;49618.41512274551;49890;50181;39686.404703928885;42633.36049959191;42792.49261495296;42806;43230.783846080565;42650.786746067315;42703.57296426996;43212;43217;43302.350464743686;35317.1170720734;40671;41281.380779288935;41797.79101104475;42193.57806422019;36115.458268126524;38464.2307153861;38695;38854.611453885096;39108.2178356437;28588.423472957613;29075.85462072676;29079.85460072686;29124.27189320284;29315.41369172562 06:13:53 INFO - PROCESS | 9827 | |2;jquery.html;376.81912681912684;384.9210911763089;388.9494365732455;399.2374564581646;402.0672040865194;18213.635727285448;20199;20524.48688782781;20652.07065682044;20727.585448291044;18926.148323325448;19083.332083377085;19664.311749088785;20470.38588842337;20599.1760329587;5536.114221724525;5736.741846616891;5884.558658100659;5885.588008839383;5941.762329506814;5650.378458369576;5753.65478071315;5771.682557459338;5773.3937936516695;5786.334571524266;5632.662040277596;5635.042042852704;5654.660720356792;5656;5728.341240757324;5683.062294721387;5713.885722285552;5728.369879313273;5751.7699292028265;5787.913181302284;4808.182608956486;5072.644914855961;5103.617228707862;5106.821261255838;5150.381954165487;11595;11695.532178712841;19869.20523179071;22867.77132228673;22934;2152.45112496314;2230.531588366445;2397.2089210560475;2486.7388924163065;2781.860906954664;9881.357711748713;10031.097201251849;10167.796644067152;11455.541778328858;14344.784828227585;1874.5969616532511;1917.3258610856194;1918.9232430702755;1948.3536411732064;1982.9206831726713;74392.62803686001;85829;85835.57082214611;86226.56886715589;86572;9445.338826282232;9654.27592930533;9873.950630246803;9947.154491868128;9966.451845148442;13128.540501082607;13202.07585469008;13213.867861321263;13319.134256273312;13332.800007999887;7671.079470463468;7749.186335434811;7807.375409967189;7933.920660793434;8017.278444939983;7611.923880761232;7663.348615367645;7694.807629809187;7773;8264.173582641688;4129.380592911028;4177.582241775798;4216.557261487561;4254.29804082323;4283.87148385549;1719.4669652407795;1804.49474147239;1828.9268429262947;1845.427917345627;1859.544411619162;1022.7471347599131;1039.8856125826153;1043.1706793099504;1045.3273865819924;1066.088494337346;19859.404217873485;20085;20290.69563956542;20407.387778366672;20579.8971005147;979.0503211884461;993.4536005197112;996.5615129343066;1019.5666841592293;1020.6070662794878;10844.295120817122;11012.802332780711;11053.889461105286;11103.83344249837;11179.385133817717;469252;470701;471981;476230;489992;75237.62381188059;86404.5679771597;92161;95650.52174739081;97768.51115744376;982.0817535604233;995.7453608453256;1016.2530540053203;1020.2501161646184;1020.3520764314566;17533.386331478338;17739;18265.17806698675;18308.816911831243;18327.175277112296;40060.39909401303;40942.385864211465;42139;42716.145677086904;43387;52807;53506;58913.70543147257;63910;64920;8283.792905177419;8307;8308.501489910625;8558.229759321692;8580.570971451527;13109;14066.226357550433;14191.07757995727;14272.14367137975;14385.352659130574;11243.437828108725;11282.605108821152;11289.71775705581;11338.886611133783;11837.112216583962;11539.88460115388;11869.465874035863;11992.460339284928;12071.758564828478;12171.391430428266;11338.319700817978;11500.712482188012;11526.654200374001;11537.769244615229;11556.47995840206;8151.551664658501;8341.374396920377;8358.331333493185;8442.113578074213;8953.718818484507;7896.526208427513;10001.599936002478;11241;11383.260088094248;11423.828642570534 06:13:53 INFO - PROCESS | 9827 | |3;mootools.html;1484.849241837576;1504.7216264990975;1605.4461210882241;1724;1742.3814545836228;7844.254795794404;8544.829103417936;8569.27161191298;9140.085991400856;9156.130167634072;8450.154984501547;8847.646094156242;8868.91131088689;8937.374383793138;8941.776455588613;2268.9886550567226;2297.563462942044;2301.0335659023167;2304.331743794298;2309.896054677535;2238.183063181943;2243.3942835434423;2259.2544460328054;2261.547690461914;2267.1271560449263;2243.1588154442084;2247.438140464884;2260.819134469247;2267.920622778203;2271.784180502858;2191.41927389242;2202.966955495669;2204.459907322708;2204.5150066985157;2204.6362350212194;2203.3059586230447;2204.7795220477983;2208.6355751301016;2215.634420320645;2218.5784700906775;8968.68609598661;9052.592633331516;9064.410813297114;9116.5441727914;9128.863067053999;4981.601471882241;5075.5939524838295;5087.287779710843;5134;5134.2812006319145;3153.7950033247766;3160.3995240904155;3269.215388306813;3289.32568823393;3294.9950265169114;999.9100080992746;1003.2375394700081;1008.1732978957258;1046.283295942282;1047.1465755409317;11613.245139065933;11690;11773.646790596296;11786.705332366673;11816.995555377804;4242.851500197478;4366.825326986885;4496.617787488035;4517.841875534341;4568.748718820497;9944.303898727165;10030.197584193247;10035.046670566284;10050.195984321237;10066.949665251626;4972.0801651694555;4999.775010124553;5027.723475208899;5039.521245481674;5041.445441001487;4261.957380426218;4609.516000819933;4659.883502912387;4731.858044258678;4765;3548.3258180945536;3609.5848977367937;3680.411134218512;3682.576503702055;3698.112453011258;993.9950300248597;1009.9444530550891;1029.1046789293362;1039.111559616532;1049.2026060194155;840.7141571865473;966.3766870368573;970.5438443931341;981.8085473332775;985.5072463768116;5873.618214816109;5881.911771323434;5946.762129514771;6028.2766068072115;6037.9433599119975;383.9212961342918;396.518230350126;399.7881123004812;401.62046865712205;402.9133736246721;3932.665723413542;4155.148194620096;4248.299030659969;4260.211860805761;4281.721688090326;10910.454477276104;11207.215494915441;11244.775104497865;11297.26567773092;11396.373199473943;11191.384473854016;11206.439678016066;11214.439278036065;11241.83137252942;11272.66182014541;7911.446198766146;8210.63052162642;8355.916440835514;8436.367272454469;8461.830763384698;5984.491318237999;6089.421504957022;6218.409251121137;6280.309165991646;6525.510586705921;10098.091171794575;10253.07722304996;10286.794264114526;10459.68620941373;10491.895081049397;10396.792064158522;10484.108850747773;10558.524866381185;10669.146468282674;10696.41169735672;6885.621290829053;7355.301246381585;7611.847763044819;7658.157602663591;7665.88501172494;8639.13608639131;8662.263707584925;8685.956570217108;8687.348448866487;8702.82594348122;7535.623218839146;7720.613969301625;7773.533587984739;7797.493162944617;7844.64699088531;7536.321731044232;7679.078510578766;7711.537307761552;7746.186650401852;7818.3354414875375;6999.335063168991;7056.50604457683;7066.8233294166;7098.858022839618;7104.360607545345;5054.519820617035;5062.949370506395;5123.103456895103;5221.817236396708;5261.579073674174;5318;5322.22827689975;5352.571794256528;5375.5162035417;5376.8118115865755 06:13:53 INFO - PROCESS | 9827 | |4;prototype.html;295.8860838577147;298.4672359837687;301.80684362008304;311.0885106637552;311.98284094374816;5591.356993945692;5647.604667673254;5648.548116150709;5662.688552129631;5703.828885133447;5559.805406810762;5559.833205003856;5566.165075238716;5571.13647384655;5580.665160090397;4078.796060196993;4140.006398464362;4235.301175306086;4251.808668609904;4253.80857861397;4243.596858298457;4258.936115958263;4259.297215959363;4261.74429534229;4282.250606143913;4239.152169566084;4242.512111107231;4243.554426785189;4272.786360681969;4276.952146724041;4029.0128918415176;4221.7255878367805;4228.556001619816;4236.682248831319;4243.342281946272;3659.8288547664756;3673.3938900081453;3675.3016926784094;3681.631836816297;3688.7602305850032;5452.536534394581;5457.645253058538;5457.890842183134;5465.453454654543;5479.849086775121;4598.758335249464;4861.82983595576;4869.269609558559;4880.389951256093;4891.290762839404;5825.1844741736195;5839.532837373;5843.2695913010875;5852.912206316909;5873.911891321633;4047.6964227683043;4048.2308361411237;4053.5338436079933;4060.2894493463527;4062.2281766464275;5955.166276721263;6080.543959203077;6082.965895797725;6102.542309326818;6121.846953826145;4126.587341265849;4139.130782535702;4141.316682747373;4150.360607559997;4153.376993450946;4195.433616461739;4197.719695492843;4198.832046718158;4199.139176468817;4208.790385047874;4661.813527458931;4850.175470170079;4870.610351171968;4874.65946864615;4881.755912204447;5844.620099693591;5859.326177489558;5868.589198756132;5870.412958704095;5894;1429.7069100834303;1433.9713205735827;1434.4477376210234;1442.596073099534;1444.1551692260146;890.875277461156;902.5938327752538;904.5838914099588;941.2564074381299;960.3709570231509;5551.195076713854;5582.074184406373;5587.346010644911;5587.525060369833;5595.8601034973635;5944;5965.671888046112;5979.5515336349945;5987.191729116601;6003.729832157476;5380.461953804666;5543.362513311021;5576.442355764472;5609.663420194802;5637.379888212294;3140.869287056658;3152.3380090181317;3168.5722427472456;3175.8094514329214;3193.1538142392283;5852.536865783554;6141.447269745744;6161.353057928853;6168.814935551941;6173.536984726164;6007.61824780303;6044.335123136451;6056.545759068;6067.393260673897;6070.696465176724;6150.692465376714;6151.323354431009;6151.507879369639;6155.84610384744;6173.444390004831;5692.886142277214;5939.732712027882;5955.843402996419;5957.642541447527;5981.551383646331;5772.220750198838;5801.6519008859605;5812.447817457335;5844.883102338014;5851.912221316598;5969.134475501115;6094.68964172705;6122.663253520921;6139.293981192041;6151.84620384494;4033.6773058155864;4063.4108054332546;4077.103037331782;4080;4080.6531444826333;5967.76128954837;5981.312149102909;5987.790427335022;5990.053232699477;6019.819405417845;5631.549476041989;5854.970725146347;5863.648181109147;5880.323762767336;5885.323187833283;5785.161151632906;5786.9131963019745;5810.273715785527;5842.152887831326;5845.18167456548;5539.8892022158525;5579.497845193952;5762.798302059407;5769.365369809234;5773.6824474654295;5852.239208902815;5883.470487656132;5962.25471816023;5964.224650795369;5982.312034116132;5596.776128954796;5727.828165155052;5739.512141468022;5803.506701930214;5807.738651760596 06:13:53 INFO - PROCESS | 9827 | |5;yui.html;732.3555271361201;768.7847402727235;774.4540099230044;801.8287672256228;844.8521508735971;14448.349824257908;15759.290831912564;15855.84144158558;16027.038377697347;16059.839401605981;13820.239886806221;13885.166889986582;13989.510367137153;13990.860091399083;14002.859971400283;656.1568384625768;784.2392878907451;803.3452736020125;809;809.2433574607761;763.3740332927002;773.7214602743009;774.0015380159588;774.2721841469029;778.4745296924553;828.2793969246734;828.2835347424465;828.8010877389413;829.2619568583965;829.7884039569932;811.2455416462687;811.4441607498882;812.5896422306697;814.1329484099415;816.9264766171043;593.4065934065934;598.3657323237383;598.4464370457353;600.5555888642417;601.3295175878907;12201.572944946973;12210.206336588093;12216.450259738333;12227.938860305641;12278.754424911453;13482.775342068548;13739.450421983109;13983.930080349533;14164;14327.856721432756;10953;10975.231733778559;11124.833127503094;11153.498092585853;11159.310108373262;3791.8862434126745;3808.6000969898314;3835.17543728097;3851.8844434666726;3924.8822535323984;67610;70430.64784676096;70883.29116708819;76325.23674763237;79090.60454697747;10898.060666335157;11013.449327533752;11115.166362522843;11170.944145279222;11359.148063895242;20878.95605219733;20910.895445522674;20925.162993480393;20994.475138121365;21021.579568408546;8438.240558349778;8541.530215838064;8549.27331176857;8593.95703021481;8716.607752651145;4519.096180763795;4563.155816173952;4607.308903664477;4699.78850951708;4792.353032340589;3425.2978139481843;3455.2398472336045;3514.262004978932;3542.6103128655827;3545;656.8784774816675;667.2326824152263;671.684308375063;672.8990651402329;677.1806114601387;655.8917778566579;678.375894177358;689.396777819408;703.809971307744;710.6139246490477;9048.095190480899;9339.486328251876;9412.670556530626;9568.95215523918;9830.164436022875;576.5070864410868;618.4155972605935;644.3878315600199;689.4622194688151;757.8332766791407;4452.688311818141;4560.384348113029;4694.671373003857;4784.162771515041;4805.807767689324;73333.26666733265;74612.62693686497;80333;124100;126290;102339.4883025595;104423;106673.46663266789;107637.461812692;111423;93543.53228233951;93660;94283.52858235665;95101;95887.52056239675;8883.644654213758;9072.274218062406;9133.862992055258;9141.63433462654;9309.348345615741;51771.74114129405;53777.73111134419;54184.64538386572;55368.44631553633;55438.168427474426;74895.62552187205;79099.20900791149;79689.60155199187;80192;82775;11076.778464430505;11294.322340659259;11416.257943233662;11445.313281203154;11826;12256;12408;12467.251964882136;12627.93686031564;13180.143290686075;11450.94274528622;11867.643970680894;11871;11873.168878178445;11879.22785018971;11682.299062056303;11734.471948762497;11734.589289374831;12324.753504930031;12343.876561234272;11449.771004580029;11598.768024639292;11744.412779361168;12064.215825971283;12114.454849531969;9889.802203956024;10126.898731012596;10208.496754885005;10229.986424756464;10378.948105259426;10143.239257055899;10525.473726313807;10602.628907988492;10621.150307975498;10642.521086550969 06:13:53 INFO - PROCESS | 9827 | __end_tp_report 06:13:53 INFO - PROCESS | 9827 | __start_cc_report 06:13:53 INFO - PROCESS | 9827 | _x_x_mozilla_cycle_collect,363 06:13:53 INFO - PROCESS | 9827 | __end_cc_report 06:13:53 INFO - PROCESS | 9827 | __startTimestamp1468070033870__endTimestamp 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | ------- Summary: start ------- 06:13:53 INFO - PROCESS | 9827 | Number of tests: 6 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#0] dojo.html Cycles:165 Average:5393.13 Median:5573.80 stddev:625.25 (11.2%) stddev-sans-first:599.07 06:13:53 INFO - PROCESS | 9827 | Values: 3031.0 3066.8 3089.9 3104.4 3104.8 5344.3 5423.5 5452.0 5465.2 5485.7 5328.8 5351.3 5395.5 5410.9 5490.0 4808.7 4826.6 4843.4 4948.3 4969.1 4820.5 5067.1 5109.1 5113.1 5117.4 4830.5 4883.4 5005.7 5011.9 5087.3 4929.4 4939.4 4958.3 4960.5 4970.3 4902.1 4903.4 4907.1 4928.4 4959.9 5185.6 5339.2 5405.4 5417.0 5422.9 5843.5 5845.5 5851.5 5855.9 5888.6 5893.9 5897.1 5898.9 5918.3 5936.0 5303.5 5363.3 5385.7 5392.7 5419.5 5885.5 5917.6 5930.4 5932.9 5954.8 5474.5 5672.3 5673.1 5677.1 5681.6 5573.8 5791.4 5816.5 5857.3 5886.2 5652.4 5698.8 5752.2 5753.9 5810.8 5779.4 5803.1 5833.0 5893.2 5911.2 4322.1 4365.5 4388.4 4440.5 4441.0 3922.7 3931.8 3936.0 3960.5 3975.6 5479.2 5501.4 5513.6 5550.0 5584.8 5784.6 5815.1 5819.6 5844.0 5851.3 5540.6 5549.9 5610.6 5613.0 5616.7 5074.5 5078.2 5080.2 5102.9 5126.6 5822.0 6066.6 6081.1 6094.7 6128.8 5870.0 5874.2 5922.5 5926.0 5966.7 6039.8 6106.2 6107.1 6129.4 6139.6 5552.8 5566.7 5570.1 5602.7 5618.5 5723.6 5731.5 5755.2 5765.4 5780.6 5560.9 5567.2 5631.9 5637.7 5645.4 5383.4 5654.0 5660.9 5661.0 5674.5 5641.2 5650.1 5675.3 5676.7 5688.2 5566.7 5729.2 5738.5 5741.5 5744.0 5507.3 5531.9 5534.9 5575.2 5603.4 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#1] ext.html Cycles:180 Average:63390.49 Median:42642.07 stddev:129859.61 (304.5%) stddev-sans-first:130138.20 06:13:53 INFO - PROCESS | 9827 | Values: 553.2 586.9 591.9 611.1 632.3 38752.4 43552.1 43557.0 43559.0 43703.3 42052.6 42667.8 42777.4 42797.0 42866.8 8775.2 8866.8 8938.3 8942.3 8964.4 8850.6 8872.8 8908.9 8910.6 8912.7 8945.8 8958.1 8996.2 8997.1 9039.9 8840.1 8936.3 8937.2 8938.6 8970.4 8700.8 8864.2 8872.5 8897.3 8918.4 41823.4 42234.0 42398.8 42420.8 42457.8 3118.3 3221.5 3253.0 3265.8 3608.1 32193.5 32638.8 32994.7 33734.5 34130.8 4318.8 4353.0 4402.3 4454.3 4601.2 374770.0 378049.4 379725.0 380202.0 380526.0 57543.4 58038.0 58148.4 58287.7 58340.4 35943.5 36787.0 36850.4 38493.2 61418.0 16907.7 17055.3 17075.6 17095.4 17128.1 12958.2 13043.7 13073.5 13131.2 13163.5 19523.9 19561.8 19586.8 19690.6 19747.1 7083.5 7166.6 7176.9 7285.2 7379.7 961.8 970.9 1021.8 1072.6 1094.3 30389.2 32777.3 32909.3 33251.5 33425.3 1073.3 1087.5 1132.7 1184.5 1211.6 16521.4 16971.6 16991.5 17006.9 17202.5 571875.1 578308.0 579215.0 580854.0 581956.0 59978.7 60062.0 60340.4 60645.0 60802.4 1268.2 1303.6 1317.8 1322.0 1324.5 31045.4 31843.5 32068.7 32114.2 32447.8 51044.7 51095.2 51790.2 51850.7 51855.2 483206.6 488051.0 488518.0 488957.0 489877.0 28023.4 28298.7 28510.0 28579.6 28689.3 45807.5 48580.0 49618.4 49890.0 50181.0 39686.4 42633.4 42792.5 42806.0 43230.8 42650.8 42703.6 43212.0 43217.0 43302.4 35317.1 40671.0 41281.4 41797.8 42193.6 36115.5 38464.2 38695.0 38854.6 39108.2 28588.4 29075.9 29079.9 29124.3 29315.4 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#2] jquery.html Cycles:180 Average:28447.81 Median:394.09 stddev:78578.31 (19939.0%) stddev-sans-first:78770.48 06:13:53 INFO - PROCESS | 9827 | Values: 376.8 384.9 388.9 399.2 402.1 18213.6 20199.0 20524.5 20652.1 20727.6 18926.1 19083.3 19664.3 20470.4 20599.2 5536.1 5736.7 5884.6 5885.6 5941.8 5650.4 5753.7 5771.7 5773.4 5786.3 5632.7 5635.0 5654.7 5656.0 5728.3 5683.1 5713.9 5728.4 5751.8 5787.9 4808.2 5072.6 5103.6 5106.8 5150.4 11595.0 11695.5 19869.2 22867.8 22934.0 2152.5 2230.5 2397.2 2486.7 2781.9 9881.4 10031.1 10167.8 11455.5 14344.8 1874.6 1917.3 1918.9 1948.4 1982.9 74392.6 85829.0 85835.6 86226.6 86572.0 9445.3 9654.3 9874.0 9947.2 9966.5 13128.5 13202.1 13213.9 13319.1 13332.8 7671.1 7749.2 7807.4 7933.9 8017.3 7611.9 7663.3 7694.8 7773.0 8264.2 4129.4 4177.6 4216.6 4254.3 4283.9 1719.5 1804.5 1828.9 1845.4 1859.5 1022.7 1039.9 1043.2 1045.3 1066.1 19859.4 20085.0 20290.7 20407.4 20579.9 979.1 993.5 996.6 1019.6 1020.6 10844.3 11012.8 11053.9 11103.8 11179.4 469252.0 470701.0 471981.0 476230.0 489992.0 75237.6 86404.6 92161.0 95650.5 97768.5 982.1 995.7 1016.3 1020.3 1020.4 17533.4 17739.0 18265.2 18308.8 18327.2 40060.4 40942.4 42139.0 42716.1 43387.0 52807.0 53506.0 58913.7 63910.0 64920.0 8283.8 8307.0 8308.5 8558.2 8580.6 13109.0 14066.2 14191.1 14272.1 14385.4 11243.4 11282.6 11289.7 11338.9 11837.1 11539.9 11869.5 11992.5 12071.8 12171.4 11338.3 11500.7 11526.7 11537.8 11556.5 8151.6 8341.4 8358.3 8442.1 8953.7 7896.5 10001.6 11241.0 11383.3 11423.8 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#3] mootools.html Cycles:180 Average:5765.94 Median:4507.23 stddev:3374.20 (74.9%) stddev-sans-first:3368.33 06:13:53 INFO - PROCESS | 9827 | Values: 1484.8 1504.7 1605.4 1724.0 1742.4 7844.3 8544.8 8569.3 9140.1 9156.1 8450.2 8847.6 8868.9 8937.4 8941.8 2269.0 2297.6 2301.0 2304.3 2309.9 2238.2 2243.4 2259.3 2261.5 2267.1 2243.2 2247.4 2260.8 2267.9 2271.8 2191.4 2203.0 2204.5 2204.5 2204.6 2203.3 2204.8 2208.6 2215.6 2218.6 8968.7 9052.6 9064.4 9116.5 9128.9 4981.6 5075.6 5087.3 5134.0 5134.3 3153.8 3160.4 3269.2 3289.3 3295.0 999.9 1003.2 1008.2 1046.3 1047.1 11613.2 11690.0 11773.6 11786.7 11817.0 4242.9 4366.8 4496.6 4517.8 4568.7 9944.3 10030.2 10035.0 10050.2 10066.9 4972.1 4999.8 5027.7 5039.5 5041.4 4262.0 4609.5 4659.9 4731.9 4765.0 3548.3 3609.6 3680.4 3682.6 3698.1 994.0 1009.9 1029.1 1039.1 1049.2 840.7 966.4 970.5 981.8 985.5 5873.6 5881.9 5946.8 6028.3 6037.9 383.9 396.5 399.8 401.6 402.9 3932.7 4155.1 4248.3 4260.2 4281.7 10910.5 11207.2 11244.8 11297.3 11396.4 11191.4 11206.4 11214.4 11241.8 11272.7 7911.4 8210.6 8355.9 8436.4 8461.8 5984.5 6089.4 6218.4 6280.3 6525.5 10098.1 10253.1 10286.8 10459.7 10491.9 10396.8 10484.1 10558.5 10669.1 10696.4 6885.6 7355.3 7611.8 7658.2 7665.9 8639.1 8662.3 8686.0 8687.3 8702.8 7535.6 7720.6 7773.5 7797.5 7844.6 7536.3 7679.1 7711.5 7746.2 7818.3 6999.3 7056.5 7066.8 7098.9 7104.4 5054.5 5062.9 5123.1 5221.8 5261.6 5318.0 5322.2 5352.6 5375.5 5376.8 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#4] prototype.html Cycles:180 Average:4866.20 Median:5596.32 stddev:1469.20 (26.3%) stddev-sans-first:1432.72 06:13:53 INFO - PROCESS | 9827 | Values: 295.9 298.5 301.8 311.1 312.0 5591.4 5647.6 5648.5 5662.7 5703.8 5559.8 5559.8 5566.2 5571.1 5580.7 4078.8 4140.0 4235.3 4251.8 4253.8 4243.6 4258.9 4259.3 4261.7 4282.3 4239.2 4242.5 4243.6 4272.8 4277.0 4029.0 4221.7 4228.6 4236.7 4243.3 3659.8 3673.4 3675.3 3681.6 3688.8 5452.5 5457.6 5457.9 5465.5 5479.8 4598.8 4861.8 4869.3 4880.4 4891.3 5825.2 5839.5 5843.3 5852.9 5873.9 4047.7 4048.2 4053.5 4060.3 4062.2 5955.2 6080.5 6083.0 6102.5 6121.8 4126.6 4139.1 4141.3 4150.4 4153.4 4195.4 4197.7 4198.8 4199.1 4208.8 4661.8 4850.2 4870.6 4874.7 4881.8 5844.6 5859.3 5868.6 5870.4 5894.0 1429.7 1434.0 1434.4 1442.6 1444.2 890.9 902.6 904.6 941.3 960.4 5551.2 5582.1 5587.3 5587.5 5595.9 5944.0 5965.7 5979.6 5987.2 6003.7 5380.5 5543.4 5576.4 5609.7 5637.4 3140.9 3152.3 3168.6 3175.8 3193.2 5852.5 6141.4 6161.4 6168.8 6173.5 6007.6 6044.3 6056.5 6067.4 6070.7 6150.7 6151.3 6151.5 6155.8 6173.4 5692.9 5939.7 5955.8 5957.6 5981.6 5772.2 5801.7 5812.4 5844.9 5851.9 5969.1 6094.7 6122.7 6139.3 6151.8 4033.7 4063.4 4077.1 4080.0 4080.7 5967.8 5981.3 5987.8 5990.1 6019.8 5631.5 5855.0 5863.6 5880.3 5885.3 5785.2 5786.9 5810.3 5842.2 5845.2 5539.9 5579.5 5762.8 5769.4 5773.7 5852.2 5883.5 5962.3 5964.2 5982.3 5596.8 5727.8 5739.5 5803.5 5807.7 06:13:53 INFO - PROCESS | 9827 | 06:13:53 INFO - PROCESS | 9827 | [#5] yui.html Cycles:180 Average:20345.97 Median:4650.99 stddev:30082.68 (646.8%) stddev-sans-first:30131.03 06:13:53 INFO - PROCESS | 9827 | Values: 732.4 768.8 774.5 801.8 844.9 14448.3 15759.3 15855.8 16027.0 16059.8 13820.2 13885.2 13989.5 13990.9 14002.9 656.2 784.2 803.3 809.0 809.2 763.4 773.7 774.0 774.3 778.5 828.3 828.3 828.8 829.3 829.8 811.2 811.4 812.6 814.1 816.9 593.4 598.4 598.4 600.6 601.3 12201.6 12210.2 12216.5 12227.9 12278.8 13482.8 13739.5 13983.9 14164.0 14327.9 10953.0 10975.2 11124.8 11153.5 11159.3 3791.9 3808.6 3835.2 3851.9 3924.9 67610.0 70430.6 70883.3 76325.2 79090.6 10898.1 11013.4 11115.2 11170.9 11359.1 20879.0 20910.9 20925.2 20994.5 21021.6 8438.2 8541.5 8549.3 8594.0 8716.6 4519.1 4563.2 4607.3 4699.8 4792.4 3425.3 3455.2 3514.3 3542.6 3545.0 656.9 667.2 671.7 672.9 677.2 655.9 678.4 689.4 703.8 710.6 9048.1 9339.5 9412.7 9569.0 9830.2 576.5 618.4 644.4 689.5 757.8 4452.7 4560.4 4694.7 4784.2 4805.8 73333.3 74612.6 80333.0 124100.0 126290.0 102339.5 104423.0 106673.5 107637.5 111423.0 93543.5 93660.0 94283.5 95101.0 95887.5 8883.6 9072.3 9133.9 9141.6 9309.3 51771.7 53777.7 54184.6 55368.4 55438.2 74895.6 79099.2 79689.6 80192.0 82775.0 11076.8 11294.3 11416.3 11445.3 11826.0 12256.0 12408.0 12467.3 12627.9 13180.1 11450.9 11867.6 11871.0 11873.2 11879.2 11682.3 11734.5 11734.6 12324.8 12343.9 11449.8 11598.8 11744.4 12064.2 12114.5 9889.8 10126.9 10208.5 10230.0 10378.9 10143.2 10525.5 10602.6 10621.2 10642.5 06:13:53 INFO - PROCESS | 9827 | -------- Summary: end -------- 06:13:53 INFO - PROCESS | 9827 | 06:13:54 INFO - TEST-INFO | 9827: exit 0 06:13:54 INFO - TEST-OK | dromaeo_css | took 1111625ms 06:13:54 INFO - TEST-START | kraken 06:13:54 INFO - operating with platform_type : linux_ 06:13:54 INFO - Initialising browser for kraken test... 06:13:54 INFO - TEST-INFO | started process 10070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYNSE3/profile http://localhost:36837/getInfo.html) 06:13:59 INFO - PROCESS | 10070 | __metrics Screen width/height:1600/1200 06:13:59 INFO - PROCESS | 10070 | colorDepth:24 06:13:59 INFO - PROCESS | 10070 | Browser inner width/height: 1024/697 06:13:59 INFO - PROCESS | 10070 | __metrics 06:13:59 ERROR - PROCESS | 10070 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 06:14:00 INFO - TEST-INFO | 10070: exit 0 06:14:00 INFO - Browser initialized. 06:14:00 INFO - Running cycle 1/1 for kraken test... 06:14:00 INFO - TEST-INFO | started process 10195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYNSE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:12 INFO - PROCESS | 10195 | RSS: Main: 167550976 06:14:12 INFO - PROCESS | 10195 | 06:14:15 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36837/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:15 INFO - PROCESS | 10195 | RSS: Main: 172494848 06:14:15 INFO - PROCESS | 10195 | 06:14:18 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36837/tests/kraken/driver.html?testName=audio-dft) 06:14:19 INFO - PROCESS | 10195 | RSS: Main: 172367872 06:14:19 INFO - PROCESS | 10195 | 06:14:22 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36837/tests/kraken/driver.html?testName=audio-fft) 06:14:22 INFO - PROCESS | 10195 | RSS: Main: 167178240 06:14:22 INFO - PROCESS | 10195 | 06:14:24 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36837/tests/kraken/driver.html?testName=audio-oscillator) 06:14:25 INFO - PROCESS | 10195 | RSS: Main: 168148992 06:14:25 INFO - PROCESS | 10195 | 06:14:27 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:28 INFO - PROCESS | 10195 | RSS: Main: 168579072 06:14:28 INFO - PROCESS | 10195 | 06:14:31 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36837/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:32 INFO - PROCESS | 10195 | RSS: Main: 168198144 06:14:32 INFO - PROCESS | 10195 | 06:14:35 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36837/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:36 INFO - PROCESS | 10195 | RSS: Main: 166416384 06:14:36 INFO - PROCESS | 10195 | 06:14:39 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36837/tests/kraken/driver.html?testName=json-parse-financial) 06:14:39 INFO - PROCESS | 10195 | RSS: Main: 167370752 06:14:39 INFO - PROCESS | 10195 | 06:14:41 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:41 INFO - PROCESS | 10195 | RSS: Main: 167997440 06:14:41 INFO - PROCESS | 10195 | 06:14:43 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:44 INFO - PROCESS | 10195 | RSS: Main: 168349696 06:14:44 INFO - PROCESS | 10195 | 06:14:46 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:46 INFO - PROCESS | 10195 | RSS: Main: 169107456 06:14:46 INFO - PROCESS | 10195 | 06:14:49 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:50 INFO - PROCESS | 10195 | RSS: Main: 169168896 06:14:50 INFO - PROCESS | 10195 | 06:14:52 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:53 INFO - PROCESS | 10195 | RSS: Main: 168833024 06:14:53 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | Cycle 1(1): loaded http://localhost:36837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36837/tests/kraken/driver.html?testName=ai-astar) 06:14:55 INFO - PROCESS | 10195 | RSS: Main: 169680896 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | __start_tp_report 06:14:55 INFO - PROCESS | 10195 | _x_x_mozilla_page_load 06:14:55 INFO - PROCESS | 10195 | _x_x_mozilla_page_load_details 06:14:55 INFO - PROCESS | 10195 | |i|pagename|runs| 06:14:55 INFO - PROCESS | 10195 | |0;ai-astar;104;116;113;122;112;113;113;111;112;111 06:14:55 INFO - PROCESS | 10195 | |1;audio-beat-detection;146;118;149;179;123;154;149;121;179;118 06:14:55 INFO - PROCESS | 10195 | |2;audio-dft;163;164;163;162;163;166;172;170;164;163 06:14:55 INFO - PROCESS | 10195 | |3;audio-fft;75;75;76;155;77;76;75;75;159;77 06:14:55 INFO - PROCESS | 10195 | |4;audio-oscillator;86;84;155;85;85;84;149;84;85;142 06:14:55 INFO - PROCESS | 10195 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;117;117;117 06:14:55 INFO - PROCESS | 10195 | |6;imaging-darkroom;147;147;147;149;148;148;147;147;148;147 06:14:55 INFO - PROCESS | 10195 | |7;imaging-desaturate;95;97;95;96;96;96;96;97;95;95 06:14:55 INFO - PROCESS | 10195 | |8;json-parse-financial;55;56;55;58;59;55;56;55;56;55 06:14:55 INFO - PROCESS | 10195 | |9;json-stringify-tinderbox;65;63;62;61;61;62;60;61;62;62 06:14:55 INFO - PROCESS | 10195 | |10;stanford-crypto-aes;78;80;75;77;77;79;82;76;81;77 06:14:55 INFO - PROCESS | 10195 | |11;stanford-crypto-ccm;123;135;120;133;140;134;127;122;177;129 06:14:55 INFO - PROCESS | 10195 | |12;stanford-crypto-pbkdf2;156;157;162;158;154;160;158;160;157;160 06:14:55 INFO - PROCESS | 10195 | |13;stanford-crypto-sha256-iterative;68;65;64;63;65;65;63;65;62;62 06:14:55 INFO - PROCESS | 10195 | __end_tp_report 06:14:55 INFO - PROCESS | 10195 | __start_cc_report 06:14:55 INFO - PROCESS | 10195 | _x_x_mozilla_cycle_collect,902 06:14:55 INFO - PROCESS | 10195 | __end_cc_report 06:14:55 INFO - PROCESS | 10195 | __startTimestamp1468070095408__endTimestamp 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | ------- Summary: start ------- 06:14:55 INFO - PROCESS | 10195 | Number of tests: 14 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:4.47 (4.0%) stddev-sans-first:3.46 06:14:55 INFO - PROCESS | 10195 | Values: 104.0 116.0 113.0 122.0 112.0 113.0 113.0 111.0 112.0 111.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.00 stddev:23.39 (15.7%) stddev-sans-first:24.79 06:14:55 INFO - PROCESS | 10195 | Values: 146.0 118.0 149.0 179.0 123.0 154.0 149.0 121.0 179.0 118.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.37 (2.1%) stddev-sans-first:3.49 06:14:55 INFO - PROCESS | 10195 | Values: 163.0 164.0 163.0 162.0 163.0 166.0 172.0 170.0 164.0 163.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:34.28 (45.4%) stddev-sans-first:35.80 06:14:55 INFO - PROCESS | 10195 | Values: 75.0 75.0 76.0 155.0 77.0 76.0 75.0 75.0 159.0 77.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.50 stddev:31.05 (36.7%) stddev-sans-first:32.25 06:14:55 INFO - PROCESS | 10195 | Values: 86.0 84.0 155.0 85.0 85.0 84.0 149.0 84.0 85.0 142.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:14:55 INFO - PROCESS | 10195 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:14:55 INFO - PROCESS | 10195 | Values: 147.0 147.0 147.0 149.0 148.0 148.0 147.0 147.0 148.0 147.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:14:55 INFO - PROCESS | 10195 | Values: 95.0 97.0 95.0 96.0 96.0 96.0 96.0 97.0 95.0 95.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.41 (2.5%) stddev-sans-first:1.45 06:14:55 INFO - PROCESS | 10195 | Values: 55.0 56.0 55.0 58.0 59.0 55.0 56.0 55.0 56.0 55.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:0.88 06:14:55 INFO - PROCESS | 10195 | Values: 65.0 63.0 62.0 61.0 61.0 62.0 60.0 61.0 62.0 62.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:2.25 (2.9%) stddev-sans-first:2.39 06:14:55 INFO - PROCESS | 10195 | Values: 78.0 80.0 75.0 77.0 77.0 79.0 82.0 76.0 81.0 77.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.50 stddev:16.40 (12.3%) stddev-sans-first:16.91 06:14:55 INFO - PROCESS | 10195 | Values: 123.0 135.0 120.0 133.0 140.0 134.0 127.0 122.0 177.0 129.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:159.00 stddev:2.35 (1.5%) stddev-sans-first:2.35 06:14:55 INFO - PROCESS | 10195 | Values: 156.0 157.0 162.0 158.0 154.0 160.0 158.0 160.0 157.0 160.0 06:14:55 INFO - PROCESS | 10195 | 06:14:55 INFO - PROCESS | 10195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:1.81 (2.8%) stddev-sans-first:1.30 06:14:55 INFO - PROCESS | 10195 | Values: 68.0 65.0 64.0 63.0 65.0 65.0 63.0 65.0 62.0 62.0 06:14:55 INFO - PROCESS | 10195 | -------- Summary: end -------- 06:14:55 INFO - PROCESS | 10195 | 06:14:56 INFO - TEST-INFO | 10195: exit 0 06:14:56 INFO - TEST-OK | kraken | took 61751ms 06:14:56 INFO - SUITE-END | took 1173s 06:14:56 INFO - Completed test suite (00:19:33) 06:14:56 INFO - javascript benchmark 06:14:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7192.221119243818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.969690303097, 3066.815991040536, 3089.922751931201, 3104.4412005838954, 3104.829234392109, 5344.305240318758, 5423.511883930445, 5452.0458919689045, 5465.180222966557, 5485.725713714318, 5328.8401347959525, 5351.331083614548, 5395.487428694278, 5410.8917821643545, 5490.039243132456, 4808.663393562452, 4826.638002149844, 4843.443004054526, 4948.331975183341, 4969.130402179622, 4820.469748327699, 5067.138586440314, 5109.080365534202, 5113.079645663797, 5117.360329958755, 4830.541098595628, 4883.389576302962, 5005.674631148963, 5011.924821127686, 5087.262346959688, 4929.433115191727, 4939.407271127452, 4958.3306253655655, 4960.503949605047, 4970.254461830718, 4902.142125128124, 4903.436104847952, 4907.11671899058, 4928.43323017854, 4959.876003099916, 5185.61107916904, 5339.199120131972, 5405.351357837085, 5416.9729151353995, 5422.891542169174, 5843.5325173985975, 5845.473907348359, 5851.502622277111, 5855.941440585582, 5888.617239879437, 5893.911591326134, 5897.115432685088, 5898.852528686817, 5918.289805223358, 5936.0, 5303.496167864047, 5363.302770639831, 5385.676859388449, 5392.676439413648, 5419.485148910847, 5885.499732522783, 5917.615355001911, 5930.406959304121, 5932.940670593325, 5954.791582294599, 5474.479924407175, 5672.347680016851, 5673.149027645886, 5677.120046392815, 5681.57388195887, 5573.804916827973, 5791.449812267828, 5816.534677225812, 5857.326407463111, 5886.175935369051, 5652.406497317805, 5698.8290351289525, 5752.165935939265, 5753.8561535961935, 5810.82567522975, 5779.393163717833, 5803.071508558694, 5833.037548804485, 5893.233879595625, 5911.172435858984, 4322.113966636832, 4365.519792822787, 4388.385626012297, 4440.511543730187, 4440.955590444119, 3922.7057970652313, 3931.76409415436, 3936.0159960009996, 3960.5247370315747, 3975.6421922027157, 5479.205515200274, 5501.394846566875, 5513.58648101394, 5550.0, 5584.832455026356, 5784.623999440023, 5815.069588865761, 5819.592628516048, 5843.970780146157, 5851.268591426072, 5540.612157148961, 5549.889002220014, 5610.579206559524, 5613.0, 5616.66300022, 5074.517920797518, 5078.238264260317, 5080.212567052113, 5102.897942041139, 5126.615503837227, 5821.970890145522, 6066.636001839904, 6081.148639190517, 6094.725737341831, 6128.842374115807, 5869.970650146722, 5874.206982057539, 5922.466977972003, 5925.970370148121, 5966.701664916737, 6039.849003774765, 6106.2061931948565, 6107.053406721965, 6129.448349648553, 6139.6009259398, 5552.750126244409, 5566.721663916707, 5570.080936645408, 5602.747876345656, 5618.494335509824, 5723.599348045597, 5731.512821410227, 5755.165501002415, 5765.365809761007, 5780.5953583248765, 5560.888782224252, 5567.220589117445, 5631.915521267102, 5637.746301416528, 5645.379008309001, 5383.434739352469, 5653.971730141323, 5660.915086273627, 5660.971695141498, 5674.4892959633835, 5641.238432811518, 5650.124230744241, 5675.290588676416, 5676.68778217202, 5688.203651488712, 5566.666000039849, 5729.169270455844, 5738.540916726568, 5741.5119714824705, 5743.971280143573, 5507.339119305709, 5531.8893622126525, 5534.916976245279, 5575.2473416088305, 5603.3836278008575], "value": 5349.769827414139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1927261453802, 586.8855573163233, 591.9230500034995, 611.1321922869527, 632.2697284636241, 38752.41871371928, 43552.128957420835, 43557.0, 43559.0, 43703.344449833196, 42052.579474205246, 42667.786661066726, 42777.35833962493, 42797.0, 42866.7856660717, 8775.210231079218, 8866.822663546725, 8938.329625278131, 8942.329325300596, 8964.372493925428, 8850.601722922453, 8872.778180545474, 8908.910910890905, 8910.554472276393, 8912.688055918044, 8945.776355591097, 8958.148975847284, 8996.19034286914, 8997.145271199226, 9039.909600903973, 8840.115988401141, 8936.329775266848, 8937.195652391316, 8938.64245430182, 8970.41692289999, 8700.825983480296, 8864.202221800004, 8872.512011839346, 8897.288216942628, 8918.375713700043, 41823.37264941028, 42234.0, 42398.788006059774, 42420.78789606032, 42457.78771106156, 3118.3451475190236, 3221.468457704476, 3252.9512057319157, 3265.8203798791055, 3608.1340478285283, 32193.51709724356, 32638.836805816056, 32994.6700532994, 33734.493982590284, 34130.82934585311, 4318.762468064255, 4353.0, 4402.3176407656865, 4454.309582014793, 4601.171789077965, 374770.0, 378049.42678725795, 379724.99999999726, 380202.0, 380526.0, 57543.42456575464, 58038.0, 58148.418515815145, 58287.708561457766, 58340.416595834344, 35943.4608480873, 36787.0, 36850.447243291375, 38493.230135397134, 61418.0, 16907.746383804253, 17055.317787288368, 17075.573110672332, 17095.401660941807, 17128.14359282031, 12958.157719748186, 13043.739125217633, 13073.477060917647, 13131.212127272394, 13163.47346106145, 19523.926184060012, 19561.804381955997, 19586.84544700082, 19690.60618787616, 19747.111379987648, 7083.468739844532, 7166.570005799668, 7176.856462870818, 7285.235050319746, 7379.704811807467, 961.7739831139677, 970.9368891022061, 1021.8058568871891, 1072.6406653770919, 1094.3379255550437, 30389.240268993453, 32777.3444531108, 32909.341813163606, 33251.5012274816, 33425.33149337048, 1073.270176280137, 1087.472575800736, 1132.7451323452322, 1184.490669012333, 1211.5759484180467, 16521.421750238685, 16971.575710607085, 16991.49025529236, 17006.89091217321, 17202.483925482255, 571875.1093667991, 578308.0, 579215.0, 580854.0, 581956.0, 59978.700106499185, 60062.0, 60340.396596034356, 60645.0, 60802.39197608056, 1268.1693490763564, 1303.5958852755675, 1317.7693903567028, 1321.953731619408, 1324.5165514587106, 31045.379092417574, 31843.522347165275, 32068.67931320657, 32114.19714507156, 32447.837760811046, 51044.74477627588, 51095.233571495715, 51790.223146652075, 51850.740746296025, 51855.22217166821, 483206.583967092, 488051.0, 488518.0, 488957.0, 489877.0, 28023.439531209668, 28298.71701283043, 28510.0, 28579.571306430003, 28689.28276793097, 45807.54192458033, 48580.0, 49618.41512274551, 49890.0, 50181.0, 39686.404703928885, 42633.36049959191, 42792.49261495296, 42806.0, 43230.783846080565, 42650.786746067315, 42703.57296426996, 43212.0, 43217.0, 43302.350464743686, 35317.1170720734, 40671.0, 41281.380779288935, 41797.79101104475, 42193.57806422019, 36115.458268126524, 38464.2307153861, 38695.0, 38854.611453885096, 39108.2178356437, 28588.423472957613, 29075.85462072676, 29079.85460072686, 29124.27189320284, 29315.41369172562], "value": 20186.602201741447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.81912681912684, 384.9210911763089, 388.9494365732455, 399.2374564581646, 402.0672040865194, 18213.635727285448, 20199.0, 20524.48688782781, 20652.07065682044, 20727.585448291044, 18926.148323325448, 19083.332083377085, 19664.311749088785, 20470.38588842337, 20599.1760329587, 5536.114221724525, 5736.741846616891, 5884.558658100659, 5885.588008839383, 5941.762329506814, 5650.378458369576, 5753.65478071315, 5771.682557459338, 5773.3937936516695, 5786.334571524266, 5632.662040277596, 5635.042042852704, 5654.660720356792, 5656.0, 5728.341240757324, 5683.062294721387, 5713.885722285552, 5728.369879313273, 5751.7699292028265, 5787.913181302284, 4808.182608956486, 5072.644914855961, 5103.617228707862, 5106.821261255838, 5150.381954165487, 11595.0, 11695.532178712841, 19869.20523179071, 22867.77132228673, 22934.0, 2152.45112496314, 2230.531588366445, 2397.2089210560475, 2486.7388924163065, 2781.860906954664, 9881.357711748713, 10031.097201251849, 10167.796644067152, 11455.541778328858, 14344.784828227585, 1874.5969616532511, 1917.3258610856194, 1918.9232430702755, 1948.3536411732064, 1982.9206831726713, 74392.62803686001, 85829.0, 85835.57082214611, 86226.56886715589, 86572.0, 9445.338826282232, 9654.27592930533, 9873.950630246803, 9947.154491868128, 9966.451845148442, 13128.540501082607, 13202.07585469008, 13213.867861321263, 13319.134256273312, 13332.800007999887, 7671.079470463468, 7749.186335434811, 7807.375409967189, 7933.920660793434, 8017.278444939983, 7611.923880761232, 7663.348615367645, 7694.807629809187, 7773.0, 8264.173582641688, 4129.380592911028, 4177.582241775798, 4216.557261487561, 4254.29804082323, 4283.87148385549, 1719.4669652407795, 1804.49474147239, 1828.9268429262947, 1845.427917345627, 1859.544411619162, 1022.7471347599131, 1039.8856125826153, 1043.1706793099504, 1045.3273865819924, 1066.088494337346, 19859.404217873485, 20085.0, 20290.69563956542, 20407.387778366672, 20579.8971005147, 979.0503211884461, 993.4536005197112, 996.5615129343066, 1019.5666841592293, 1020.6070662794878, 10844.295120817122, 11012.802332780711, 11053.889461105286, 11103.83344249837, 11179.385133817717, 469252.0, 470701.0, 471981.0, 476230.0, 489992.0, 75237.62381188059, 86404.5679771597, 92161.0, 95650.52174739081, 97768.51115744376, 982.0817535604233, 995.7453608453256, 1016.2530540053203, 1020.2501161646184, 1020.3520764314566, 17533.386331478338, 17739.0, 18265.17806698675, 18308.816911831243, 18327.175277112296, 40060.39909401303, 40942.385864211465, 42139.0, 42716.145677086904, 43387.0, 52807.0, 53506.0, 58913.70543147257, 63910.0, 64920.0, 8283.792905177419, 8307.0, 8308.501489910625, 8558.229759321692, 8580.570971451527, 13109.0, 14066.226357550433, 14191.07757995727, 14272.14367137975, 14385.352659130574, 11243.437828108725, 11282.605108821152, 11289.71775705581, 11338.886611133783, 11837.112216583962, 11539.88460115388, 11869.465874035863, 11992.460339284928, 12071.758564828478, 12171.391430428266, 11338.319700817978, 11500.712482188012, 11526.654200374001, 11537.769244615229, 11556.47995840206, 8151.551664658501, 8341.374396920377, 8358.331333493185, 8442.113578074213, 8953.718818484507, 7896.526208427513, 10001.599936002478, 11241.0, 11383.260088094248, 11423.828642570534], "value": 9058.801754732192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.849241837576, 1504.7216264990975, 1605.4461210882241, 1724.0, 1742.3814545836228, 7844.254795794404, 8544.829103417936, 8569.27161191298, 9140.085991400856, 9156.130167634072, 8450.154984501547, 8847.646094156242, 8868.91131088689, 8937.374383793138, 8941.776455588613, 2268.9886550567226, 2297.563462942044, 2301.0335659023167, 2304.331743794298, 2309.896054677535, 2238.183063181943, 2243.3942835434423, 2259.2544460328054, 2261.547690461914, 2267.1271560449263, 2243.1588154442084, 2247.438140464884, 2260.819134469247, 2267.920622778203, 2271.784180502858, 2191.41927389242, 2202.966955495669, 2204.459907322708, 2204.5150066985157, 2204.6362350212194, 2203.3059586230447, 2204.7795220477983, 2208.6355751301016, 2215.634420320645, 2218.5784700906775, 8968.68609598661, 9052.592633331516, 9064.410813297114, 9116.5441727914, 9128.863067053999, 4981.601471882241, 5075.5939524838295, 5087.287779710843, 5134.0, 5134.2812006319145, 3153.7950033247766, 3160.3995240904155, 3269.215388306813, 3289.32568823393, 3294.9950265169114, 999.9100080992746, 1003.2375394700081, 1008.1732978957258, 1046.283295942282, 1047.1465755409317, 11613.245139065933, 11690.0, 11773.646790596296, 11786.705332366673, 11816.995555377804, 4242.851500197478, 4366.825326986885, 4496.617787488035, 4517.841875534341, 4568.748718820497, 9944.303898727165, 10030.197584193247, 10035.046670566284, 10050.195984321237, 10066.949665251626, 4972.0801651694555, 4999.775010124553, 5027.723475208899, 5039.521245481674, 5041.445441001487, 4261.957380426218, 4609.516000819933, 4659.883502912387, 4731.858044258678, 4765.0, 3548.3258180945536, 3609.5848977367937, 3680.411134218512, 3682.576503702055, 3698.112453011258, 993.9950300248597, 1009.9444530550891, 1029.1046789293362, 1039.111559616532, 1049.2026060194155, 840.7141571865473, 966.3766870368573, 970.5438443931341, 981.8085473332775, 985.5072463768116, 5873.618214816109, 5881.911771323434, 5946.762129514771, 6028.2766068072115, 6037.9433599119975, 383.9212961342918, 396.518230350126, 399.7881123004812, 401.62046865712205, 402.9133736246721, 3932.665723413542, 4155.148194620096, 4248.299030659969, 4260.211860805761, 4281.721688090326, 10910.454477276104, 11207.215494915441, 11244.775104497865, 11297.26567773092, 11396.373199473943, 11191.384473854016, 11206.439678016066, 11214.439278036065, 11241.83137252942, 11272.66182014541, 7911.446198766146, 8210.63052162642, 8355.916440835514, 8436.367272454469, 8461.830763384698, 5984.491318237999, 6089.421504957022, 6218.409251121137, 6280.309165991646, 6525.510586705921, 10098.091171794575, 10253.07722304996, 10286.794264114526, 10459.68620941373, 10491.895081049397, 10396.792064158522, 10484.108850747773, 10558.524866381185, 10669.146468282674, 10696.41169735672, 6885.621290829053, 7355.301246381585, 7611.847763044819, 7658.157602663591, 7665.88501172494, 8639.13608639131, 8662.263707584925, 8685.956570217108, 8687.348448866487, 8702.82594348122, 7535.623218839146, 7720.613969301625, 7773.533587984739, 7797.493162944617, 7844.64699088531, 7536.321731044232, 7679.078510578766, 7711.537307761552, 7746.186650401852, 7818.3354414875375, 6999.335063168991, 7056.50604457683, 7066.8233294166, 7098.858022839618, 7104.360607545345, 5054.519820617035, 5062.949370506395, 5123.103456895103, 5221.817236396708, 5261.579073674174, 5318.0, 5322.22827689975, 5352.571794256528, 5375.5162035417, 5376.8118115865755], "value": 4459.785024853128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8860838577147, 298.4672359837687, 301.80684362008304, 311.0885106637552, 311.98284094374816, 5591.356993945692, 5647.604667673254, 5648.548116150709, 5662.688552129631, 5703.828885133447, 5559.805406810762, 5559.833205003856, 5566.165075238716, 5571.13647384655, 5580.665160090397, 4078.796060196993, 4140.006398464362, 4235.301175306086, 4251.808668609904, 4253.80857861397, 4243.596858298457, 4258.936115958263, 4259.297215959363, 4261.74429534229, 4282.250606143913, 4239.152169566084, 4242.512111107231, 4243.554426785189, 4272.786360681969, 4276.952146724041, 4029.0128918415176, 4221.7255878367805, 4228.556001619816, 4236.682248831319, 4243.342281946272, 3659.8288547664756, 3673.3938900081453, 3675.3016926784094, 3681.631836816297, 3688.7602305850032, 5452.536534394581, 5457.645253058538, 5457.890842183134, 5465.453454654543, 5479.849086775121, 4598.758335249464, 4861.82983595576, 4869.269609558559, 4880.389951256093, 4891.290762839404, 5825.1844741736195, 5839.532837373, 5843.2695913010875, 5852.912206316909, 5873.911891321633, 4047.6964227683043, 4048.2308361411237, 4053.5338436079933, 4060.2894493463527, 4062.2281766464275, 5955.166276721263, 6080.543959203077, 6082.965895797725, 6102.542309326818, 6121.846953826145, 4126.587341265849, 4139.130782535702, 4141.316682747373, 4150.360607559997, 4153.376993450946, 4195.433616461739, 4197.719695492843, 4198.832046718158, 4199.139176468817, 4208.790385047874, 4661.813527458931, 4850.175470170079, 4870.610351171968, 4874.65946864615, 4881.755912204447, 5844.620099693591, 5859.326177489558, 5868.589198756132, 5870.412958704095, 5894.0, 1429.7069100834303, 1433.9713205735827, 1434.4477376210234, 1442.596073099534, 1444.1551692260146, 890.875277461156, 902.5938327752538, 904.5838914099588, 941.2564074381299, 960.3709570231509, 5551.195076713854, 5582.074184406373, 5587.346010644911, 5587.525060369833, 5595.8601034973635, 5944.0, 5965.671888046112, 5979.5515336349945, 5987.191729116601, 6003.729832157476, 5380.461953804666, 5543.362513311021, 5576.442355764472, 5609.663420194802, 5637.379888212294, 3140.869287056658, 3152.3380090181317, 3168.5722427472456, 3175.8094514329214, 3193.1538142392283, 5852.536865783554, 6141.447269745744, 6161.353057928853, 6168.814935551941, 6173.536984726164, 6007.61824780303, 6044.335123136451, 6056.545759068, 6067.393260673897, 6070.696465176724, 6150.692465376714, 6151.323354431009, 6151.507879369639, 6155.84610384744, 6173.444390004831, 5692.886142277214, 5939.732712027882, 5955.843402996419, 5957.642541447527, 5981.551383646331, 5772.220750198838, 5801.6519008859605, 5812.447817457335, 5844.883102338014, 5851.912221316598, 5969.134475501115, 6094.68964172705, 6122.663253520921, 6139.293981192041, 6151.84620384494, 4033.6773058155864, 4063.4108054332546, 4077.103037331782, 4080.0, 4080.6531444826333, 5967.76128954837, 5981.312149102909, 5987.790427335022, 5990.053232699477, 6019.819405417845, 5631.549476041989, 5854.970725146347, 5863.648181109147, 5880.323762767336, 5885.323187833283, 5785.161151632906, 5786.9131963019745, 5810.273715785527, 5842.152887831326, 5845.18167456548, 5539.8892022158525, 5579.497845193952, 5762.798302059407, 5769.365369809234, 5773.6824474654295, 5852.239208902815, 5883.470487656132, 5962.25471816023, 5964.224650795369, 5982.312034116132, 5596.776128954796, 5727.828165155052, 5739.512141468022, 5803.506701930214, 5807.738651760596], "value": 4379.2779876336635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.3555271361201, 768.7847402727235, 774.4540099230044, 801.8287672256228, 844.8521508735971, 14448.349824257908, 15759.290831912564, 15855.84144158558, 16027.038377697347, 16059.839401605981, 13820.239886806221, 13885.166889986582, 13989.510367137153, 13990.860091399083, 14002.859971400283, 656.1568384625768, 784.2392878907451, 803.3452736020125, 809.0, 809.2433574607761, 763.3740332927002, 773.7214602743009, 774.0015380159588, 774.2721841469029, 778.4745296924553, 828.2793969246734, 828.2835347424465, 828.8010877389413, 829.2619568583965, 829.7884039569932, 811.2455416462687, 811.4441607498882, 812.5896422306697, 814.1329484099415, 816.9264766171043, 593.4065934065934, 598.3657323237383, 598.4464370457353, 600.5555888642417, 601.3295175878907, 12201.572944946973, 12210.206336588093, 12216.450259738333, 12227.938860305641, 12278.754424911453, 13482.775342068548, 13739.450421983109, 13983.930080349533, 14164.0, 14327.856721432756, 10953.0, 10975.231733778559, 11124.833127503094, 11153.498092585853, 11159.310108373262, 3791.8862434126745, 3808.6000969898314, 3835.17543728097, 3851.8844434666726, 3924.8822535323984, 67610.0, 70430.64784676096, 70883.29116708819, 76325.23674763237, 79090.60454697747, 10898.060666335157, 11013.449327533752, 11115.166362522843, 11170.944145279222, 11359.148063895242, 20878.95605219733, 20910.895445522674, 20925.162993480393, 20994.475138121365, 21021.579568408546, 8438.240558349778, 8541.530215838064, 8549.27331176857, 8593.95703021481, 8716.607752651145, 4519.096180763795, 4563.155816173952, 4607.308903664477, 4699.78850951708, 4792.353032340589, 3425.2978139481843, 3455.2398472336045, 3514.262004978932, 3542.6103128655827, 3545.0, 656.8784774816675, 667.2326824152263, 671.684308375063, 672.8990651402329, 677.1806114601387, 655.8917778566579, 678.375894177358, 689.396777819408, 703.809971307744, 710.6139246490477, 9048.095190480899, 9339.486328251876, 9412.670556530626, 9568.95215523918, 9830.164436022875, 576.5070864410868, 618.4155972605935, 644.3878315600199, 689.4622194688151, 757.8332766791407, 4452.688311818141, 4560.384348113029, 4694.671373003857, 4784.162771515041, 4805.807767689324, 73333.26666733265, 74612.62693686497, 80333.0, 124100.0, 126290.0, 102339.4883025595, 104423.0, 106673.46663266789, 107637.461812692, 111423.0, 93543.53228233951, 93660.0, 94283.52858235665, 95101.0, 95887.52056239675, 8883.644654213758, 9072.274218062406, 9133.862992055258, 9141.63433462654, 9309.348345615741, 51771.74114129405, 53777.73111134419, 54184.64538386572, 55368.44631553633, 55438.168427474426, 74895.62552187205, 79099.20900791149, 79689.60155199187, 80192.0, 82775.0, 11076.778464430505, 11294.322340659259, 11416.257943233662, 11445.313281203154, 11826.0, 12256.0, 12408.0, 12467.251964882136, 12627.93686031564, 13180.143290686075, 11450.94274528622, 11867.643970680894, 11871.0, 11873.168878178445, 11879.22785018971, 11682.299062056303, 11734.471948762497, 11734.589289374831, 12324.753504930031, 12343.876561234272, 11449.771004580029, 11598.768024639292, 11744.412779361168, 12064.215825971283, 12114.454849531969, 9889.802203956024, 10126.898731012596, 10208.496754885005, 10229.986424756464, 10378.948105259426, 10143.239257055899, 10525.473726313807, 10602.628907988492, 10621.150307975498, 10642.521086550969], "value": 7243.4896188988, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 122.0, 112.0, 113.0, 113.0, 111.0, 112.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 149.0, 179.0, 123.0, 154.0, 149.0, 121.0, 179.0, 118.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 163.0, 166.0, 172.0, 170.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 155.0, 77.0, 76.0, 75.0, 75.0, 159.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 155.0, 85.0, 85.0, 84.0, 149.0, 84.0, 85.0, 142.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 58.0, 59.0, 55.0, 56.0, 55.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 75.0, 77.0, 77.0, 79.0, 82.0, 76.0, 81.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 135.0, 120.0, 133.0, 140.0, 134.0, 127.0, 122.0, 177.0, 129.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 162.0, 158.0, 154.0, 160.0, 158.0, 160.0, 157.0, 160.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 63.0, 65.0, 65.0, 63.0, 65.0, 62.0, 62.0], "value": 64.2, "unit": "score"}]}]} 06:14:56 INFO - Return code: 0 06:14:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:56 ERROR - # TBPL SUCCESS # 06:14:56 INFO - Running post-action listener: _resource_record_post_action 06:14:56 INFO - ##### 06:14:56 INFO - ##### Finished run-tests step (success) 06:14:56 INFO - ##### 06:14:56 INFO - Running post-run listener: _resource_record_post_run 06:14:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 558817280; Read time: 0; Write time: 709640 06:14:56 INFO - TinderboxPrint: CPU usage
13.3% 06:14:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:14:56 INFO - TinderboxPrint: I/O write bytes / time
558,817,280 / 709,640 06:14:56 INFO - TinderboxPrint: CPU idle
8,234.4 (86.6%) 06:14:56 INFO - TinderboxPrint: CPU user
1,211.8 (12.8%) 06:14:56 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:56 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 263442432; Read time: 0; Write time: 386812 06:14:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295374848; Read time: 0; Write time: 322828 06:14:57 INFO - Running post-run listener: _upload_blobber_files 06:14:57 INFO - Blob upload gear active. 06:14:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:57 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 06:14:57 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'] 06:14:57 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 06:14:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:58 INFO - (blobuploader) - INFO - Done attempting. 06:14:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:14:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:59 INFO - (blobuploader) - INFO - Done attempting. 06:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:02 INFO - (blobuploader) - INFO - Done attempting. 06:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:02 INFO - Return code: 0 06:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/352662c35d36f2b46d10a125358b472de7838db23db5adf0736d5753bc51055528ea4da861a2c40ed9a33dcb4e97846594ded9a877e06e6918202d1fb832a27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b013d302f77c8d63654f47edcacf1e0471e25ea2c99fc0ce55c53e59b41376229336550c1a7fc9e298b3beae1d470ac664cbce0e106c81583f21e7fe7c59ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30517524bb0f7492d3e8b27e3cce8d667139909140ec2ece6e3f993c1c31fd4688159631dc9fa4597243437ad8af37fff602471ece0f7134b31057a3dd7b6bfd"} 06:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:02 INFO - Contents: 06:15:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/352662c35d36f2b46d10a125358b472de7838db23db5adf0736d5753bc51055528ea4da861a2c40ed9a33dcb4e97846594ded9a877e06e6918202d1fb832a27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b013d302f77c8d63654f47edcacf1e0471e25ea2c99fc0ce55c53e59b41376229336550c1a7fc9e298b3beae1d470ac664cbce0e106c81583f21e7fe7c59ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30517524bb0f7492d3e8b27e3cce8d667139909140ec2ece6e3f993c1c31fd4688159631dc9fa4597243437ad8af37fff602471ece0f7134b31057a3dd7b6bfd"} 06:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:02 INFO - Copying logs to upload dir... 06:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.831958 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-09 06:15:02.655986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 06:15:02.659914) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/352662c35d36f2b46d10a125358b472de7838db23db5adf0736d5753bc51055528ea4da861a2c40ed9a33dcb4e97846594ded9a877e06e6918202d1fb832a27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b013d302f77c8d63654f47edcacf1e0471e25ea2c99fc0ce55c53e59b41376229336550c1a7fc9e298b3beae1d470ac664cbce0e106c81583f21e7fe7c59ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30517524bb0f7492d3e8b27e3cce8d667139909140ec2ece6e3f993c1c31fd4688159631dc9fa4597243437ad8af37fff602471ece0f7134b31057a3dd7b6bfd"} build_url:https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/a0cb_bkVQ1ukd_7MLD4sOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/352662c35d36f2b46d10a125358b472de7838db23db5adf0736d5753bc51055528ea4da861a2c40ed9a33dcb4e97846594ded9a877e06e6918202d1fb832a27b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b013d302f77c8d63654f47edcacf1e0471e25ea2c99fc0ce55c53e59b41376229336550c1a7fc9e298b3beae1d470ac664cbce0e106c81583f21e7fe7c59ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30517524bb0f7492d3e8b27e3cce8d667139909140ec2ece6e3f993c1c31fd4688159631dc9fa4597243437ad8af37fff602471ece0f7134b31057a3dd7b6bfd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 06:15:02.684736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 06:15:02.685050) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1468067552.38470-60297302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 06:15:02.770358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 06:15:02.770691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 06:15:02.770985) ========= ========= Total master_lag: 0.17 =========