builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1468897574.32 results: success (0) buildid: 20160718184319 builduid: 6bf00cda762643e188970aab6b9179a6 revision: 0ce39c20b7063e84b1f942a971af1ccf912915ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.324452) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.324899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.325233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.344730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.345069) ========= 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=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 20:06:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-07-18 20:06:14 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113357 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.834173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:14.834548) ========= 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=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015453 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.071345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.071718) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0ce39c20b7063e84b1f942a971af1ccf912915ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0ce39c20b7063e84b1f942a971af1ccf912915ee --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=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 20:06:15,497 truncating revision to first 12 chars 2016-07-18 20:06:15,497 Setting DEBUG logging. 2016-07-18 20:06:15,497 attempt 1/10 2016-07-18 20:06:15,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0ce39c20b706?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 20:06:15,812 unpacking tar archive at: autoland-0ce39c20b706/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.768873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.769451) ========= script_repo_revision: 0ce39c20b7063e84b1f942a971af1ccf912915ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.770133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.770595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:06:15.781311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-18 20:06:15.782029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:16 INFO - MultiFileLogger online at 20160718 20:06:16 in /builds/slave/test 20:06:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:06:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:16 INFO - {'append_to_log': False, 20:06:16 INFO - 'base_work_dir': '/builds/slave/test', 20:06:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:06:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:16 INFO - 'branch': 'Autoland-Non-PGO', 20:06:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:16 INFO - 'config_files': ('talos/linux_config.py',), 20:06:16 INFO - 'default_actions': ('clobber', 20:06:16 INFO - 'read-buildbot-config', 20:06:16 INFO - 'download-and-extract', 20:06:16 INFO - 'populate-webroot', 20:06:16 INFO - 'create-virtualenv', 20:06:16 INFO - 'install', 20:06:16 INFO - 'run-tests'), 20:06:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:16 INFO - 'download_minidump_stackwalk': True, 20:06:16 INFO - 'download_symbols': 'ondemand', 20:06:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:16 INFO - 'installer_path': 'installer.exe', 20:06:16 INFO - 'log_level': 'info', 20:06:16 INFO - 'log_name': 'talos', 20:06:16 INFO - 'log_to_console': True, 20:06:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:16 INFO - 'opt_config_files': (), 20:06:16 INFO - 'pip_index': False, 20:06:16 INFO - 'sps_profile': False, 20:06:16 INFO - 'sps_profile_interval': 0, 20:06:16 INFO - 'suite': 'dromaeojs', 20:06:16 INFO - 'system_bits': '32', 20:06:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:16 INFO - 'title': 'talos-linux64-ix-008', 20:06:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:16 INFO - 'use_talos_json': True, 20:06:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:16 INFO - 'work_dir': 'build'} 20:06:16 INFO - ##### 20:06:16 INFO - ##### Running clobber step. 20:06:16 INFO - ##### 20:06:16 INFO - Running pre-action listener: _resource_record_pre_action 20:06:16 INFO - Running main action method: clobber 20:06:16 INFO - rmtree: /builds/slave/test/build 20:06:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:16 INFO - Running post-action listener: _resource_record_post_action 20:06:16 INFO - ##### 20:06:16 INFO - ##### Finished clobber step (success) 20:06:16 INFO - ##### 20:06:16 INFO - ##### 20:06:16 INFO - ##### Running read-buildbot-config step. 20:06:16 INFO - ##### 20:06:16 INFO - Running pre-action listener: _resource_record_pre_action 20:06:16 INFO - Running main action method: read_buildbot_config 20:06:16 INFO - Using buildbot properties: 20:06:16 INFO - { 20:06:16 INFO - "project": "", 20:06:16 INFO - "product": "firefox", 20:06:16 INFO - "script_repo_revision": "production", 20:06:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:06:16 INFO - "repository": "", 20:06:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:06:16 INFO - "buildid": "20160718184319", 20:06:16 INFO - "pgo_build": "False", 20:06:16 INFO - "basedir": "/builds/slave/test", 20:06:16 INFO - "buildnumber": 155, 20:06:16 INFO - "slavename": "talos-linux64-ix-008", 20:06:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:06:16 INFO - "platform": "ubuntu64_hw", 20:06:16 INFO - "scheduler": "tests-autoland-linux64-talos", 20:06:16 INFO - "branch": "autoland", 20:06:16 INFO - "repo_path": "integration/autoland", 20:06:16 INFO - "revision": "0ce39c20b7063e84b1f942a971af1ccf912915ee", 20:06:16 INFO - "stage_platform": "linux64", 20:06:16 INFO - "builduid": "6bf00cda762643e188970aab6b9179a6", 20:06:16 INFO - "slavebuilddir": "test" 20:06:16 INFO - } 20:06:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:06:16 INFO - Running post-action listener: _resource_record_post_action 20:06:16 INFO - ##### 20:06:16 INFO - ##### Finished read-buildbot-config step (success) 20:06:16 INFO - ##### 20:06:16 INFO - ##### 20:06:16 INFO - ##### Running download-and-extract step. 20:06:16 INFO - ##### 20:06:16 INFO - Running pre-action listener: _resource_record_pre_action 20:06:16 INFO - Running main action method: download_and_extract 20:06:16 INFO - mkdir: /builds/slave/test/build/tests 20:06:16 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')]} 20:06:16 INFO - https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:17 INFO - Downloaded 1361 bytes. 20:06:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:06:17 INFO - Using the following test package requirements: 20:06:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'jsshell-linux-x86_64.zip'], 20:06:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:17 INFO - https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:18 INFO - Downloaded 22764883 bytes. 20:06:18 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'] 20:06:18 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 20:06:19 INFO - Return code: 0 20:06:19 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 20:06:19 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')]} 20:06:19 INFO - https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:27 INFO - Downloaded 22764883 bytes. 20:06:27 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'] 20:06:27 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 20:06:29 INFO - Return code: 0 20:06:29 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')]} 20:06:29 INFO - https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:30 INFO - Downloaded 14403317 bytes. 20:06:30 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'] 20:06:30 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 20:06:30 INFO - Return code: 0 20:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:30 INFO - https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTBqwQkwTrOnpqHquJv4Kw/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 20:06:32 INFO - Downloaded 57136209 bytes. 20:06:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:06:32 INFO - mkdir: /builds/slave/test/properties 20:06:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:32 INFO - Contents: 20:06:32 INFO - build_url:https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - Running post-action listener: set_extra_try_arguments 20:06:33 INFO - ##### 20:06:33 INFO - ##### Finished download-and-extract step (success) 20:06:33 INFO - ##### 20:06:33 INFO - ##### 20:06:33 INFO - ##### Running populate-webroot step. 20:06:33 INFO - ##### 20:06:33 INFO - Running pre-action listener: _resource_record_pre_action 20:06:33 INFO - Running main action method: populate_webroot 20:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:33 INFO - '--tppagecycles', 20:06:33 INFO - '7'], 20:06:33 INFO - 'tests': ['tsvgm']}}, 20:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['damp', 'tps']}, 20:06:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'tests': ['damp', 'tps']}, 20:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['dromaeo_dom']}, 20:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['basic_compositor_video']}, 20:06:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['a11yr', 20:06:33 INFO - 'ts_paint', 20:06:33 INFO - 'tpaint', 20:06:33 INFO - 'sessionrestore', 20:06:33 INFO - 'sessionrestore_no_auto_restore', 20:06:33 INFO - 'tabpaint']}, 20:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['tsvgx', 20:06:33 INFO - 'tsvgr_opacity', 20:06:33 INFO - 'tart', 20:06:33 INFO - 'tscrollx', 20:06:33 INFO - 'cart']}, 20:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:33 INFO - 'tsvgr_opacity', 20:06:33 INFO - 'tart', 20:06:33 INFO - 'tscrollx', 20:06:33 INFO - 'cart']}, 20:06:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['tp5o']}, 20:06:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'tests': ['tp5o']}, 20:06:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'talos_options': ['--disable-e10s', 20:06:33 INFO - '--xperf_path', 20:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:33 INFO - 'tests': ['tp5n']}, 20:06:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:33 INFO - 'talos_options': ['--xperf_path', 20:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:33 INFO - 'tests': ['tp5n']}}, 20:06:33 INFO - 'talos.zip': {'path': '', 20:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - ##### 20:06:33 INFO - ##### Finished populate-webroot step (success) 20:06:33 INFO - ##### 20:06:33 INFO - ##### 20:06:33 INFO - ##### Running create-virtualenv step. 20:06:33 INFO - ##### 20:06:33 INFO - Running pre-action listener: _resource_record_pre_action 20:06:33 INFO - Running main action method: create_virtualenv 20:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:33 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 20:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:33 INFO - Using real prefix '/usr' 20:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:33 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:35 INFO - Installing pip.................done. 20:06:35 INFO - Return code: 0 20:06:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:35 INFO - Using env: {'DISPLAY': ':0', 20:06:35 INFO - 'HOME': '/home/cltbld', 20:06:35 INFO - 'LANG': 'en_US.UTF-8', 20:06:35 INFO - 'LANGUAGE': 'en_US:en', 20:06:35 INFO - 'LOGNAME': 'cltbld', 20:06:35 INFO - 'MAIL': '/var/mail/cltbld', 20:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:35 INFO - 'MOZ_NO_REMOTE': '1', 20:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:35 INFO - 'NO_EM_RESTART': '1', 20:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:35 INFO - 'PWD': '/builds/slave/test', 20:06:35 INFO - 'SHELL': '/bin/bash', 20:06:35 INFO - 'SHLVL': '1', 20:06:35 INFO - 'TERM': 'linux', 20:06:35 INFO - 'TMOUT': '86400', 20:06:35 INFO - 'USER': 'cltbld', 20:06:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:35 INFO - '_': '/tools/buildbot/bin/python'} 20:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:35 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 20:06:35 INFO - Cleaning up... 20:06:35 INFO - Return code: 0 20:06:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:06:35 INFO - Using env: {'DISPLAY': ':0', 20:06:35 INFO - 'HOME': '/home/cltbld', 20:06:35 INFO - 'LANG': 'en_US.UTF-8', 20:06:35 INFO - 'LANGUAGE': 'en_US:en', 20:06:35 INFO - 'LOGNAME': 'cltbld', 20:06:35 INFO - 'MAIL': '/var/mail/cltbld', 20:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:35 INFO - 'MOZ_NO_REMOTE': '1', 20:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:35 INFO - 'NO_EM_RESTART': '1', 20:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:35 INFO - 'PWD': '/builds/slave/test', 20:06:35 INFO - 'SHELL': '/bin/bash', 20:06:35 INFO - 'SHLVL': '1', 20:06:35 INFO - 'TERM': 'linux', 20:06:35 INFO - 'TMOUT': '86400', 20:06:35 INFO - 'USER': 'cltbld', 20:06:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:35 INFO - '_': '/tools/buildbot/bin/python'} 20:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:36 INFO - Downloading/unpacking psutil>=3.1.1 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:36 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 20:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:38 INFO - Installing collected packages: psutil 20:06:38 INFO - Running setup.py install for psutil 20:06:38 INFO - building 'psutil._psutil_linux' extension 20:06:38 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 20:06:38 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 20:06:38 INFO - building 'psutil._psutil_posix' extension 20:06:38 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 20:06:38 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 20:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:38 INFO - Successfully installed psutil 20:06:38 INFO - Cleaning up... 20:06:38 INFO - Return code: 0 20:06:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:06:38 INFO - Using env: {'DISPLAY': ':0', 20:06:38 INFO - 'HOME': '/home/cltbld', 20:06:38 INFO - 'LANG': 'en_US.UTF-8', 20:06:38 INFO - 'LANGUAGE': 'en_US:en', 20:06:38 INFO - 'LOGNAME': 'cltbld', 20:06:38 INFO - 'MAIL': '/var/mail/cltbld', 20:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:38 INFO - 'MOZ_NO_REMOTE': '1', 20:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:38 INFO - 'NO_EM_RESTART': '1', 20:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:38 INFO - 'PWD': '/builds/slave/test', 20:06:38 INFO - 'SHELL': '/bin/bash', 20:06:38 INFO - 'SHLVL': '1', 20:06:38 INFO - 'TERM': 'linux', 20:06:38 INFO - 'TMOUT': '86400', 20:06:38 INFO - 'USER': 'cltbld', 20:06:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:38 INFO - '_': '/tools/buildbot/bin/python'} 20:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:40 INFO - Installing collected packages: mozsystemmonitor 20:06:40 INFO - Running setup.py install for mozsystemmonitor 20:06:41 INFO - Successfully installed mozsystemmonitor 20:06:41 INFO - Cleaning up... 20:06:41 INFO - Return code: 0 20:06:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:41 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:41 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 20:06:41 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 20:06:41 INFO - Using env: {'DISPLAY': ':0', 20:06:41 INFO - 'HOME': '/home/cltbld', 20:06:41 INFO - 'LANG': 'en_US.UTF-8', 20:06:41 INFO - 'LANGUAGE': 'en_US:en', 20:06:41 INFO - 'LOGNAME': 'cltbld', 20:06:41 INFO - 'MAIL': '/var/mail/cltbld', 20:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:41 INFO - 'MOZ_NO_REMOTE': '1', 20:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:41 INFO - 'NO_EM_RESTART': '1', 20:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:41 INFO - 'PWD': '/builds/slave/test', 20:06:41 INFO - 'SHELL': '/bin/bash', 20:06:41 INFO - 'SHLVL': '1', 20:06:41 INFO - 'TERM': 'linux', 20:06:41 INFO - 'TMOUT': '86400', 20:06:41 INFO - 'USER': 'cltbld', 20:06:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:41 INFO - '_': '/tools/buildbot/bin/python'} 20:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:41 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:43 INFO - warning: no files found matching '*.txt' 20:06:43 INFO - no previously-included directories found matching 'build' 20:06:43 INFO - no previously-included directories found matching 'dist' 20:06:43 INFO - no previously-included directories found matching '.git*' 20:06:43 INFO - Installing collected packages: jsonschema, functools32 20:06:43 INFO - Running setup.py install for functools32 20:06:43 INFO - warning: no files found matching '*.txt' 20:06:43 INFO - no previously-included directories found matching 'build' 20:06:43 INFO - no previously-included directories found matching 'dist' 20:06:43 INFO - no previously-included directories found matching '.git*' 20:06:43 INFO - Successfully installed jsonschema functools32 20:06:43 INFO - Cleaning up... 20:06:43 INFO - Return code: 0 20:06:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:43 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')]} 20:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:43 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')]} 20:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:43 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:43 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 20:06:43 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 20:06:43 INFO - Using env: {'DISPLAY': ':0', 20:06:43 INFO - 'HOME': '/home/cltbld', 20:06:43 INFO - 'LANG': 'en_US.UTF-8', 20:06:43 INFO - 'LANGUAGE': 'en_US:en', 20:06:43 INFO - 'LOGNAME': 'cltbld', 20:06:43 INFO - 'MAIL': '/var/mail/cltbld', 20:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:43 INFO - 'MOZ_NO_REMOTE': '1', 20:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:43 INFO - 'NO_EM_RESTART': '1', 20:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:43 INFO - 'PWD': '/builds/slave/test', 20:06:43 INFO - 'SHELL': '/bin/bash', 20:06:43 INFO - 'SHLVL': '1', 20:06:43 INFO - 'TERM': 'linux', 20:06:43 INFO - 'TMOUT': '86400', 20:06:43 INFO - 'USER': 'cltbld', 20:06:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:43 INFO - '_': '/tools/buildbot/bin/python'} 20:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:43 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:43 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 20:06:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:46 INFO - Downloading docopt-0.6.1.tar.gz 20:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:46 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:46 INFO - Running setup.py install for blobuploader 20:06:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:46 INFO - Running setup.py install for requests 20:06:46 INFO - Running setup.py install for docopt 20:06:47 INFO - Successfully installed blobuploader requests docopt 20:06:47 INFO - Cleaning up... 20:06:47 INFO - Return code: 0 20:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:47 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')]} 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 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')]} 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:47 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 20:06:47 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 20:06:47 INFO - Using env: {'DISPLAY': ':0', 20:06:47 INFO - 'HOME': '/home/cltbld', 20:06:47 INFO - 'LANG': 'en_US.UTF-8', 20:06:47 INFO - 'LANGUAGE': 'en_US:en', 20:06:47 INFO - 'LOGNAME': 'cltbld', 20:06:47 INFO - 'MAIL': '/var/mail/cltbld', 20:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:47 INFO - 'MOZ_NO_REMOTE': '1', 20:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:47 INFO - 'NO_EM_RESTART': '1', 20:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:47 INFO - 'PWD': '/builds/slave/test', 20:06:47 INFO - 'SHELL': '/bin/bash', 20:06:47 INFO - 'SHLVL': '1', 20:06:47 INFO - 'TERM': 'linux', 20:06:47 INFO - 'TMOUT': '86400', 20:06:47 INFO - 'USER': 'cltbld', 20:06:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:47 INFO - '_': '/tools/buildbot/bin/python'} 20:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:47 INFO - Running setup.py (path:/tmp/pip-ykWsmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:47 INFO - Running setup.py (path:/tmp/pip-XBgsof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:47 INFO - Running setup.py (path:/tmp/pip-3pV6xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:47 INFO - Running setup.py (path:/tmp/pip-NR0Kj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:47 INFO - Running setup.py (path:/tmp/pip-ZN2ijV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:47 INFO - Running setup.py (path:/tmp/pip-dRTxFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:47 INFO - Running setup.py (path:/tmp/pip-xPMtMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:47 INFO - Running setup.py (path:/tmp/pip-EPHcib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:47 INFO - Running setup.py (path:/tmp/pip-7m_W9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:48 INFO - Running setup.py (path:/tmp/pip-XNqrPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:48 INFO - Running setup.py (path:/tmp/pip-I0eTFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:48 INFO - Running setup.py (path:/tmp/pip-MTo4mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:48 INFO - Running setup.py (path:/tmp/pip-WgWtTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:48 INFO - Running setup.py (path:/tmp/pip-38Hujl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:48 INFO - Running setup.py (path:/tmp/pip-MyRpjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:48 INFO - Running setup.py (path:/tmp/pip-iqSSUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:48 INFO - Running setup.py (path:/tmp/pip-9GyfaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:48 INFO - Running setup.py install for manifestparser 20:06:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:48 INFO - Running setup.py install for mozcrash 20:06:48 INFO - Running setup.py install for mozdebug 20:06:48 INFO - Running setup.py install for mozdevice 20:06:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozfile 20:06:49 INFO - Running setup.py install for mozhttpd 20:06:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozinfo 20:06:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozInstall 20:06:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozleak 20:06:49 INFO - Running setup.py install for mozlog 20:06:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for moznetwork 20:06:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozprocess 20:06:49 INFO - Running setup.py install for mozprofile 20:06:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozrunner 20:06:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozscreenshot 20:06:50 INFO - Running setup.py install for moztest 20:06:50 INFO - Running setup.py install for mozversion 20:06:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:50 INFO - Cleaning up... 20:06:50 INFO - Return code: 0 20:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:50 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')]} 20:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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')]} 20:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:50 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 20:06:50 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 20:06:50 INFO - Using env: {'DISPLAY': ':0', 20:06:50 INFO - 'HOME': '/home/cltbld', 20:06:50 INFO - 'LANG': 'en_US.UTF-8', 20:06:50 INFO - 'LANGUAGE': 'en_US:en', 20:06:50 INFO - 'LOGNAME': 'cltbld', 20:06:50 INFO - 'MAIL': '/var/mail/cltbld', 20:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:50 INFO - 'MOZ_NO_REMOTE': '1', 20:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:50 INFO - 'NO_EM_RESTART': '1', 20:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:50 INFO - 'PWD': '/builds/slave/test', 20:06:50 INFO - 'SHELL': '/bin/bash', 20:06:50 INFO - 'SHLVL': '1', 20:06:50 INFO - 'TERM': 'linux', 20:06:50 INFO - 'TMOUT': '86400', 20:06:50 INFO - 'USER': 'cltbld', 20:06:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:50 INFO - '_': '/tools/buildbot/bin/python'} 20:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:50 INFO - Running setup.py (path:/tmp/pip-g8H5CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:50 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)) 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:50 INFO - Running setup.py (path:/tmp/pip-IFuwT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:50 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)) 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:50 INFO - Running setup.py (path:/tmp/pip-kTnTbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:50 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)) 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:50 INFO - Running setup.py (path:/tmp/pip-DbtqGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:50 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)) 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:50 INFO - Running setup.py (path:/tmp/pip-DEQA2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:50 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)) 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:50 INFO - Running setup.py (path:/tmp/pip-z2admV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:51 INFO - Running setup.py (path:/tmp/pip-1A1EaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:51 INFO - Running setup.py (path:/tmp/pip-gZ_pv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:51 INFO - Running setup.py (path:/tmp/pip-_bONxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:51 INFO - Running setup.py (path:/tmp/pip-ePeyIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:51 INFO - Running setup.py (path:/tmp/pip-5aZhkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:51 INFO - Running setup.py (path:/tmp/pip-UG144n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:51 INFO - Running setup.py (path:/tmp/pip-Mrw7KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:51 INFO - Running setup.py (path:/tmp/pip-q68UMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:51 INFO - Running setup.py (path:/tmp/pip-mqdzKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:51 INFO - Running setup.py (path:/tmp/pip-VEvlnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:51 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)) 20:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:51 INFO - Running setup.py (path:/tmp/pip-uKJyhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:51 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)) 20:06:51 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)) 20:06:51 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)) 20:06:51 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)) 20:06:51 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)) 20:06:51 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)) 20:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:53 INFO - Downloading blessings-1.6.tar.gz 20:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:53 INFO - Installing collected packages: blessings 20:06:53 INFO - Running setup.py install for blessings 20:06:53 INFO - Successfully installed blessings 20:06:53 INFO - Cleaning up... 20:06:53 INFO - Return code: 0 20:06:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Current package versions: 20:06:54 INFO - argparse == 1.2.1 20:06:54 INFO - blessings == 1.6 20:06:54 INFO - blobuploader == 1.2.4 20:06:54 INFO - docopt == 0.6.1 20:06:54 INFO - functools32 == 3.2.3-2 20:06:54 INFO - jsonschema == 2.5.1 20:06:54 INFO - manifestparser == 1.1 20:06:54 INFO - mozInstall == 1.12 20:06:54 INFO - mozcrash == 0.17 20:06:54 INFO - mozdebug == 0.1 20:06:54 INFO - mozdevice == 0.48 20:06:54 INFO - mozfile == 1.2 20:06:54 INFO - mozhttpd == 0.7 20:06:54 INFO - mozinfo == 0.9 20:06:54 INFO - mozleak == 0.1 20:06:54 INFO - mozlog == 3.2 20:06:54 INFO - moznetwork == 0.27 20:06:54 INFO - mozprocess == 0.23 20:06:54 INFO - mozprofile == 0.28 20:06:54 INFO - mozrunner == 6.12 20:06:54 INFO - mozscreenshot == 0.1 20:06:54 INFO - mozsystemmonitor == 0.3 20:06:54 INFO - moztest == 0.7 20:06:54 INFO - mozversion == 1.4 20:06:54 INFO - psutil == 3.1.1 20:06:54 INFO - requests == 1.2.3 20:06:54 INFO - wsgiref == 0.1.2 20:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:54 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')]} 20:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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')]} 20:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:54 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 20:06:54 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 20:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 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)) 20:06:54 INFO - Cleaning up... 20:06:54 INFO - Return code: 0 20:06:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:54 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')]} 20:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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')]} 20:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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 0x12e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, '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': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', '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 20:06:54 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 20:06:54 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 20:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:54 INFO - Cleaning up... 20:06:54 INFO - Return code: 0 20:06:54 INFO - Running post-action listener: _resource_record_post_action 20:06:54 INFO - Running post-action listener: _start_resource_monitoring 20:06:54 INFO - Starting resource monitoring. 20:06:54 INFO - ##### 20:06:54 INFO - ##### Finished create-virtualenv step (success) 20:06:54 INFO - ##### 20:06:54 INFO - ##### 20:06:54 INFO - ##### Running install step. 20:06:54 INFO - ##### 20:06:54 INFO - Running pre-action listener: _resource_record_pre_action 20:06:54 INFO - Running main action method: install 20:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Output received: 20:06:54 INFO - Usage: mozinstall [options] installer 20:06:54 INFO - Options: 20:06:54 INFO - -h, --help show this help message and exit 20:06:54 INFO - -d DEST, --destination=DEST 20:06:54 INFO - Directory to install application into. [default: 20:06:54 INFO - "/builds/slave/test"] 20:06:54 INFO - --app=APP Application being installed. [default: firefox] 20:06:54 INFO - mkdir: /builds/slave/test/build/application 20:06:54 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'] 20:06:54 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 20:07:11 INFO - Reading from file tmpfile_stdout 20:07:11 INFO - Output received: 20:07:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:11 INFO - Running post-action listener: _resource_record_post_action 20:07:11 INFO - ##### 20:07:11 INFO - ##### Finished install step (success) 20:07:11 INFO - ##### 20:07:11 INFO - ##### 20:07:11 INFO - ##### Running run-tests step. 20:07:11 INFO - ##### 20:07:11 INFO - Running pre-action listener: _resource_record_pre_action 20:07:11 INFO - Running main action method: run_tests 20:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:11 INFO - Python 2.7.3 20:07:11 INFO - Return code: 0 20:07:11 INFO - grabbing minidump binary from tooltool 20:07:11 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')]} 20:07:11 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 0x15a33b0>, '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 0x15a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:11 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 20:07:11 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 20:07:11 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 20:07:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:11 INFO - Return code: 0 20:07:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:07:11 INFO - Using env: {'DISPLAY': ':0', 20:07:11 INFO - 'HOME': '/home/cltbld', 20:07:11 INFO - 'LANG': 'en_US.UTF-8', 20:07:11 INFO - 'LANGUAGE': 'en_US:en', 20:07:11 INFO - 'LOGNAME': 'cltbld', 20:07:11 INFO - 'MAIL': '/var/mail/cltbld', 20:07:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:11 INFO - 'MOZ_NO_REMOTE': '1', 20:07:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:11 INFO - 'NO_EM_RESTART': '1', 20:07:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:11 INFO - 'PWD': '/builds/slave/test', 20:07:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:11 INFO - 'SHELL': '/bin/bash', 20:07:11 INFO - 'SHLVL': '1', 20:07:11 INFO - 'TERM': 'linux', 20:07:11 INFO - 'TMOUT': '86400', 20:07:11 INFO - 'USER': 'cltbld', 20:07:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672', 20:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:11 INFO - '_': '/tools/buildbot/bin/python'} 20:07:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:07:11 INFO - mozversion application_buildid: 20160718184319 20:07:11 INFO - mozversion application_changeset: 0ce39c20b7063e84b1f942a971af1ccf912915ee 20:07:11 INFO - mozversion application_display_name: Nightly 20:07:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:11 INFO - mozversion application_name: Firefox 20:07:11 INFO - mozversion application_remotingname: firefox 20:07:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:07:11 INFO - mozversion application_vendor: Mozilla 20:07:11 INFO - mozversion application_version: 50.0a1 20:07:11 INFO - mozversion platform_buildid: 20160718184319 20:07:11 INFO - mozversion platform_changeset: 0ce39c20b7063e84b1f942a971af1ccf912915ee 20:07:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:07:11 INFO - mozversion platform_version: 50.0a1 20:07:11 INFO - using testdate: 1468897631 20:07:11 INFO - actual date: 1468897631 20:07:11 INFO - starting webserver on 'localhost:44249' 20:07:11 INFO - SUITE-START | Running 2 tests 20:07:11 INFO - TEST-START | dromaeo_css 20:07:11 INFO - operating with platform_type : linux_ 20:07:11 INFO - Initialising browser for dromaeo_css test... 20:07:11 INFO - TEST-INFO | started process 21871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoWDdTn/profile http://localhost:44249/getInfo.html) 20:07:15 INFO - PROCESS | 21871 | __metrics Screen width/height:1600/1200 20:07:15 INFO - PROCESS | 21871 | colorDepth:24 20:07:15 INFO - PROCESS | 21871 | Browser inner width/height: 1024/697 20:07:15 INFO - PROCESS | 21871 | __metrics 20:07:16 INFO - PROCESS | 21871 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:07:16 INFO - PROCESS | 21871 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:17 INFO - TEST-INFO | 21871: exit 0 20:07:17 INFO - Browser initialized. 20:07:17 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:17 INFO - TEST-INFO | started process 21953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoWDdTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:29 INFO - PROCESS | 21953 | RSS: Main: 159256576 20:07:29 INFO - PROCESS | 21953 | 20:08:20 INFO - PROCESS | 21953 | 1468897700816 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] 20:10:33 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44249/tests/dromaeo/cssquery-ext.html) 20:10:34 INFO - PROCESS | 21953 | RSS: Main: 270168064 20:10:34 INFO - PROCESS | 21953 | 20:13:37 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-ext.html (next: http://localhost:44249/tests/dromaeo/cssquery-jquery.html) 20:13:38 INFO - PROCESS | 21953 | RSS: Main: 241328128 20:13:38 INFO - PROCESS | 21953 | 20:16:40 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44249/tests/dromaeo/cssquery-mootools.html) 20:16:41 INFO - PROCESS | 21953 | RSS: Main: 243118080 20:16:41 INFO - PROCESS | 21953 | 20:19:43 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44249/tests/dromaeo/cssquery-prototype.html) 20:19:43 INFO - PROCESS | 21953 | RSS: Main: 240795648 20:19:43 INFO - PROCESS | 21953 | 20:22:46 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44249/tests/dromaeo/cssquery-yui.html) 20:22:47 INFO - PROCESS | 21953 | RSS: Main: 221831168 20:22:47 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | Cycle 1(1): loaded http://localhost:44249/tests/dromaeo/cssquery-yui.html (next: http://localhost:44249/tests/dromaeo/cssquery-dojo.html) 20:25:50 INFO - PROCESS | 21953 | RSS: Main: 272977920 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | __start_tp_report 20:25:50 INFO - PROCESS | 21953 | _x_x_mozilla_page_load 20:25:50 INFO - PROCESS | 21953 | _x_x_mozilla_page_load_details 20:25:50 INFO - PROCESS | 21953 | |i|pagename|runs| 20:25:50 INFO - PROCESS | 21953 | |0;dojo.html;2649.4436168404636;2660.4812061647986;2686.8119231653786;2688.1129227354977;2696.447228318195;4472.753998530079;4527.501974782771;4776.140294746949;4837.516248375161;4878.634102442314;4705.85882423527;4709.0346478971815;4729.574338309551;4733.976330118345;4753.0493901219725;4300.419443375135;4311.978440107795;4379.4963579188325;4410.536893626171;4513.52607976161;4439.334099885011;4443.666724995622;4464.6874718769695;4497.257952437843;4516.864494065183;4257.723247988871;4294.871153865389;4304.80628371724;4339.761313127777;4414.889627759299;4356.912861742779;4358.585934336233;4366.19225443294;4366.6506679465565;4404.0531285773395;4385.342198670225;4395.142947125312;4396.098799746044;4411.404460397837;4435.423394958667;4619.076184763027;4691.741954192518;4790.568848803624;4796.664233503656;4832.057748738997;5057.898842023175;5110.795568177268;5111.667741596784;5115.820946266863;5167.612429067835;5140.485951404867;5167.069927413064;5171.4311425743135;5178.042062218502;5185.766640501187;4633.8841528961375;4709.458412282632;4751.192297309466;4784.952150478521;4837.105135549899;5263.052650522943;5277.577793776489;5285.630005899627;5287.048331300326;5294.7617357219015;5069.493050694901;5072.036313100499;5073.797048118107;5074.16276314404;5080.13637681595;4826.203676393356;5030.119729047402;5078.5937125029905;5079.72061536619;5104.464031276662;5042.193249080129;5055.823046193365;5063.13926632466;5072.492750724972;5095.082885080721;5030.798768049311;5037.622178336566;5038.546530812245;5038.672486288379;5079.72061536619;4257.3613957905945;4300.65594752419;4301;4345.283028300359;4390.714603550823;3797.430385442206;3799.525059367579;3842.404427313715;3864.652181303696;3866.6713329367317;4336.1978034063795;4350.564943505624;4356.346548017759;4392.38506609075;4395.802188901507;4979.45226025137;4989.675671081368;5048.1418158913075;5155.922661160085;5199.584033277329;4275.0381164238415;4283.571642835692;4295.398644189816;4343.3484977253665;4343.9348409773875;4579.267317229227;4582.289745089516;4588.220002599566;4591.150637132141;4634;4581.381513495636;4593.954060459353;4749.596284315734;4760.143174228672;4766.046790641816;5091.0836049511445;5129.9743501282255;5145.279660847559;5146.125158722951;5197.142471492161;4810.326554282473;4814.446338670958;4820.132376172322;4821.951780482291;4873.049755297683;4869.586085182799;4941.654084214214;4959.851204463872;5061.215511595708;5115.744212789271;5054.69671819692;5067.797288108434;5071.923921141112;5075.086484432837;5104;4940.209566469348;4940.60475161979;4941.2835138905375;4945.629077819106;4968.701877887338;4706.976465117653;4931.753412329297;4973.6269779765935;4988.501149884983;4992.425871024733;4915.926261106015;4930.063287975273;4952.57903078228;4996.475370086088;5002.499750025114;5054.721990290569;5063.392392912874;5068.189089745623;5069.9746501267255;5131.358580177478;4663.696859704109;4805.975970120127;4829.44461386945;4848.0788650156355;4951.356323678043 20:25:50 INFO - PROCESS | 21953 | |1;ext.html;552.7864183187796;575.7380391921677;582.5572564850713;585.5959388022262;594.0584174084075;27872.44255114899;39962.40056399156;41131;41223.17553648925;41357;42161.156776864445;42896.356554651706;42996.78501607488;43043;43049.13901721971;7462.365698915599;7702.42231832612;7715;7799.571023593714;7949.920500794976;7597.430192735539;9987.950060249725;10288.331258468213;10289.691309260734;10699.518521666505;9962.750931226705;9967.90032099677;9987;9990.400575965465;10011.14905233056;7528.999999999945;7758.650860711282;10262.948685256562;10339.0694837465;10340.741481462948;7739.187385324516;7800.141984381714;9914.9504252479;10261.897381026243;10268.100401425685;40084.59915400867;40411.7979410104;40465.59534404677;40498.190036199405;40515.39226911599;3023.5011223148153;3050.4051709916575;3079.9846000770076;3115.79747316426;3474.409350410436;30596.388072238653;31063;31081.22296942572;31117;32398.83800580982;3400.7449441292;3515.2793677296095;3517.3668739626855;3537.451694987281;3574.964250357515;267888;268128;268140.6592967042;268376;268390;55658;55705.44294557084;55808.72095639496;56037.7198114015;56041;59032.40967590355;59253;59293.70353148207;59299;59352.40647593469;15432.459863904709;15858.207089645472;15859.603509912344;15862.206889655472;15868.127253000965;10581.682549523526;10804.13566914645;10812;11543.711407214887;11880.584179553847;16595.83404165967;16706.916465417595;17173.141342932802;17331.220095095752;17466.30134794594;5774.220480235199;5836.678982655994;5941.722529656145;5951.464368206882;5992.910106348409;815.3762371785589;824.9298809601131;961.4423634292094;1031.0823367203195;1037.9532921018572;26709.332266693098;28735.712642873303;29124.563131553045;29371.853140734158;29513.409731805245;975.5902520941222;995.8058178655093;1018.7147598672384;1026.5329275179774;1030.701096681969;14744.189069601274;15209.6197595061;15249.772164758504;15397.615059623375;15544.300506477235;394544;395289;398271;399435;399815;50852.23721644178;50987.74506127446;51038.74480627573;51100.74449627728;51177.74411127921;1085.8914108589079;1122.3602546548552;1157.5080590749067;1167.8073117935614;1219.890209881115;26801.659917003682;29993;30368.392632147676;30665.386692266475;31008.379832402774;44360.55639443564;44874.775626121664;44882;44898;44910;318532;319288;319555;319663;321056;24806.25581232566;25430.109946152537;25927.870360648078;25970.09104681327;27379.589306160025;43054.569454305056;43281.56718432775;43514;44175.33736993883;44571.33143002792;36938.261234775695;37837.62162378341;38174.427383588714;38256.617433825304;38505;36924.26151477009;36948.261034779694;37453.62546374501;37577.4363384544;37905.24189516139;34364;34728.305433891685;34977.30045399129;36644.63355366412;37033;31779.36441271208;33156;33717;34072.48891266583;34101.488477672356;25767.484650307262;25867.22398328053;25927.74072259253;26037.349066273495;26074.60888086718 20:25:50 INFO - PROCESS | 21953 | |2;jquery.html;340.909658940381;370.92396058807947;375.7088256601136;375.93421151298514;392.8055612471827;13137.67155821105;16392.180390980448;16714.164291785393;17509.474715758515;18349.174287157075;17454.738178927328;17600.911995440038;17660.735088973677;17884.105794710278;18251;5096.847094587159;5250.737463126848;5578.609497335168;5585.301837270341;5680.375158732557;3479.8260086995674;5183.948160518403;5446.591505637073;5467.043267428204;5482.588805839558;5488.067028605126;5512.862178445551;5517.227588137664;5528.806491772789;5536.778528858841;5293.285406470135;5566.86082847928;5567.944320556783;5570;5571.9721401392935;5291.28567643367;5359.169328754049;5362.249285100089;5370.301860758115;5387.488188622075;12667.36663166838;12763.680907977281;12819.038572107129;12896.355182240944;12921.935390322988;1914.5979344337707;1965.744453221072;1990.6814909614393;2096.371088673392;2450.7916827069544;9335.439873607538;9373.531323433801;9392.577334019985;9804.36271642348;9875.851862222073;1652.3638399216268;1663.69221693987;1672.8912620679616;1737.444017914268;1758.2439550993067;65573.67213163903;68993.3100668992;69104.30895691029;70727;71138.99999999948;9239.953800231091;9523.380980236263;9844.3601165924;9975.850362244571;10205.693829185137;12670.936645316715;13241.536546221028;13276.53532126371;13337.066405351727;13758.449662013607;7187.748428804966;7517.962410187914;7668.309852113337;7731.110922244014;7780.02749656293;7037.331453511908;7170.318819712119;7268.23683513234;7283.016792732913;7528.134264559536;4250.192463431938;4256.1487702459635;4352.39066530686;4374.4531933508315;4390.385346051556;1794.8115447878047;1833.7524434201212;1840.5398650337415;1895.6303520813585;1902.6670332691724;779.6959185917497;812.8049268175713;839.1608391608391;925.9629215278931;949.7897107775811;16841.6631667366;17409.47771566855;17599.296028158988;17670.674699397598;17837.197326120357;830.1449507007792;859.3168431097292;862.2929198057533;871.4945331707721;888.1961824548794;9370.95314523423;9706.369086009387;9809.21526277896;9814.705558833246;9994.20046396301;389158;391400;393152;394890;397041;80294.19705802984;80944;81621;81704.59147704224;82156;901.7384958362132;917.9311551633655;919.2508105893676;933.2533972821716;933.869258303838;15349.232538372813;15535.922320388325;15568.688626227638;15626.45307414235;15919.204039798195;29040.41919161647;31097.045780650802;37361;38135.809320953216;39354.803225983684;45729.51245850519;47151.764241179946;50647;51539.742301289756;51969.22046169386;7615.809604759926;7701.730439434593;7798.376129909707;7984.720534781255;8043.1554686757045;11869.21677958322;12259.570915017932;12294.81557776652;12314.568990085305;12380.4428800706;10423.791524169626;10554.366737995744;10752.784944300915;10821.350718956888;10969.561217551209;10379.429131397543;10460.110890574386;10547.103496202908;10608.522616482123;10760.892391076302;5414.944085903211;10685.626003089854;10725.356478611307;10876.401797901191;11114.333140011626;7707.884381734167;7799.688012479664;7802.414818888493;7905.130435652189;7988.960055199686;8258.174182581934;10270.43512606784;10752.838707419238;10888.67333979982;11026.889731102587 20:25:50 INFO - PROCESS | 21953 | |3;mootools.html;1357.3349058961112;1400.3488377904275;1453.2080016391067;1663.2764747334918;1686.0979376033818;7599.886001709971;8065.91934080659;8133.796655083626;8151.91848081519;8163.836723265538;6687;7583.658735356908;7788.688452461909;7792.92207077929;7989;2214.966775498369;2251.6284813005836;2251.8311126665485;2252.3468194223656;2258.4015235962484;1872.129459801199;2133.925312614059;2148.709924160242;2231.0852550454315;2232.720909886264;2139.3474990128007;2220.2784095169054;2225.899834507451;2239.8096161826265;2242.6075436798496;2070.7618623858298;2124.2671278408925;2125.744910610721;2128.0423809285808;2181.1057466438842;2180.6401943679275;2184.0936011555186;2186.8250539956766;2186.8797216153107;2188.0919418441326;8072.515649061075;8099.959500202462;8105.27052565272;8108.9594552026865;8116.715914942949;4633;4754.904901901942;4809.567138957511;4810.855674329776;4812.230043193073;2850.2161905475955;2852.415254872746;2998.220462679697;3006.038067818299;3007.0678089792236;814.6782021101632;833.5665453963966;834.045018453873;834.5076404921126;837.5853952293593;10634.734131646694;10637.627683031134;10637.829838717735;10725.141988640968;10747.946260268727;4185.3931179979345;4307.440032795716;4455.04216593434;4457.799399026987;4458.8439404620685;8987.370884038055;9058.954705226432;9120.087991200828;9125.087491250822;9132.908670913206;4651.953480465152;4652.302154676826;4653.60444362233;4666.2067448533835;4668.8132474701315;4210.431591735138;4276.465441819772;4281.05816720321;4282.678799090018;4286.592773686495;3428.9314213715584;3493.1965647901125;3545.858165673396;3559.8430510084327;3569.39320315547;987.807377561383;1082.7130810335268;1086.2830531848942;1094.698957786615;1113.2207454781685;698.4866123399297;812.8496228197803;858.1890113842484;861.4529773593688;894.9910500894907;5178.300929374562;5244.554212891947;5253.737313134328;5446.074167391553;5506.614536982453;425.4447945431242;434.81303039693233;440.28673548851066;443.9178751930903;606.3239487970969;3481.2689335239884;3783.810809459516;3795.7153213509096;3808.257389808961;3843.1737176507186;9381.953090234505;9835.754106147404;9915.851262231072;9932.851007234898;9944.651937182309;8318.70884519039;9110.498922559324;9461.479618621042;9477.905220947703;9707.029297070236;7294.635268236567;7363.889541656879;7383.9261607384315;7387.963060184772;7398.999999999893;5339.973300133474;5376.73116344189;5388;5547.41752116022;5624.803131890364;8857.202851743374;8883.689070882489;9008.32437567172;9014;9026.684066057656;8812.64749410042;9057.77355566116;9100.31747618918;9145.176934075966;9183.816323673356;6999.790006299819;7080;7105.28947105306;7113;7114.14630244374;7585.127710313164;7653.387728981556;7660.578668173304;7675.961620191863;7687.88468172989;6685.832854178684;6794.320567943166;6800.421964132906;6926.272741362084;6955.061066755923;6529.379708927644;6652.866942661023;6723.731050757915;6758.628275444898;6780.38976492118;6378.425941665272;6450.677466126581;6451.806445806634;6456.677166141768;6469.482441404771;4361.694681372401;4612.238980568303;4652.697574657636;4666.533346665306;4721.150192965162;4580.519045500175;4612.53874612536;4668.6498512611015;4695.154872123051;4756.048790241896 20:25:50 INFO - PROCESS | 21953 | |4;prototype.html;295.47700569991116;296.94654962106813;302.0289768394611;311.0978163326352;311.7303532444436;4944.456109827921;4973.801047958086;4984.352034235549;4994.525520075587;5001.874953126169;4663.347131401598;4775;4788.281757736341;4797.376341075656;4912.606991440685;3750.4374343848367;3801.0497375656155;3805.676517496016;3889.611038896102;3904.4728961590104;3857.6528112469873;3865.729398942075;3886.5724770275247;3893.260280546687;3899.7660140391667;3603.171270607762;3771.41543060826;3844.4233364995193;3863.652271295583;3863.864764733221;3787.1289603391238;3801.144742432958;3805.7335986480957;3810.12367155553;3815.179736356669;3336.065901547571;3338.8998330050135;3346.8159251241173;3348.7153591944716;3357.9160520986925;4713.457952335491;4765.809367625291;4802.879928001793;4806.461932181704;4819.662623616348;4107.691923105779;4340.934885976713;4363.738175709467;4372.759498227596;4383.167198232358;5123.2315152727015;5134.4095429025765;5145.716985565792;5151.639385243035;5156.613254005964;3650.1787097903025;3662.926741465182;3664.358737220976;3665.9450108248398;3670.596234414212;5135.691858488465;5372.811951581715;5377.139657654796;5392.678793695531;5395.21769343443;3696.500972368696;3714.7213958953184;3722.088088418355;3725.962740372616;3731.8880433587037;3763.3790424580184;3766.8304926277833;3770.377887648562;3773.981130094332;3774.226283611908;4307.6769242306955;4309.159713855831;4320.78396080201;4323.135372925428;4323.546027667113;4842.564169224786;5155.304033955443;5159.2003239497935;5165.276861239429;5173.948260517347;1241;1289.7356042011365;1307.1830106183636;1308.3523655790254;1310.0567591334225;862.4911302331654;893.7229458867772;895.1630225738955;895.2748273898163;903.503073309677;4412.889677758082;4421.734695918255;4427.977860110744;4438.911221775611;4439.955600444019;5253.44838791929;5259.15853463444;5260.815871444558;5261.921071183935;5272.92090618641;4313.705888233518;4401.801918913657;4421.668374871898;4434.778261086997;4439.977800110979;2774.819636723647;2779.88880444784;2791.5812628105946;2799.174243598143;2805.789565782534;4927.876803079952;4934.915677701437;4939.678920870132;4947.826826061142;4959.429665588431;5174.508421699932;5365.651232669864;5434.266374039533;5501.724913754297;5513.283273174462;5025.115581656879;5039.395272567315;5040.823571174918;5042.890564075898;5047.6214283929585;5218.347706536683;5365.946340536545;5367.677939323653;5376.462353764592;5382.273393092039;5255.372313842926;5271.841844744664;5272.446393128666;5280.471952804689;5288;5020.7991680333835;5023.794289370598;5045.672031317952;5052.5705315048635;5053.393592768744;3739.383001804672;3750.343689854319;3754.2679177560112;3754.887353379403;3758.8120593969647;5069.518395752398;5335.4527187116855;5347.43851895561;5348.304720386481;5360.490753378423;5164.406093299169;5167.974160129175;5170.603936936931;5179.378474582923;5196.142636465092;4939.975300123477;5175.896482070413;5184.870378240575;5184.896302074013;5193.37679478465;4846.684965477232;4959.62802789785;5112.309838171948;5128.512791284822;5143.553818941244;5227.738613069408;5234.319538459976;5239.842804715865;5253.737313134405;5271.20931860224;5121.385433747974;5127.846164615067;5128.1794912813775;5138.537531622172;5139.6145289102715 20:25:50 INFO - PROCESS | 21953 | |5;yui.html;618.4742968476795;658.8352911772057;660.9074729537864;675.3078094952676;698.0855079845406;12367;13713;14012.22932738699;14415.207163605997;14481.78277325841;14906.47827326041;15011.549653510385;15039.097654140733;15117.54647360581;15127.62180945477;622.7322251431882;746.5259560179298;772.822250882296;785.0775338976708;790.6600161930368;783.7335305995961;788.0385929166408;789.7354386280603;790.4427378698033;791.1020991175029;833.1918039501674;833.8332333533317;834.3742193354984;834.9123342049088;834.9123342049088;647.7182425644836;659.4987809264993;662.2781168526329;669.5012215899137;826.3182874128838;588.3616276340176;605.1044454207753;608.6013661052018;609.7439075588263;610.2737742086903;12844.229346239163;12858.421371038326;12859.871401285962;12866.806997895039;12866.935665321707;12290.877091229062;12656.17734847232;12668.429920653592;12728.299943503103;12763.936180319131;11753.882461175364;11801.173917825756;11911.225770324902;12025;12044.096692748079;4162.687798415101;4243.066525364415;4245.681573881971;4255.446791917062;4304.139172165548;59373.10940335898;59639.701801490715;59876.99999999956;59933;59994;9938.652147174815;10019.849702254473;10032.799344013225;10420.635277765241;10586.682399528027;17329.913350433166;17334.219960101826;17335.306587736348;17361.47915562535;17636.470905872844;6968.930310696929;7107;7210.062691850026;7273.12722473296;7301.014363060919;3733.383991641403;3781.300459415017;3802.752821066622;3834.118152824866;3865.4974853268895;2793.9860300698774;2915.19832046189;2917.766578673701;2919.299368151628;2919.3285544324926;503.77833753148496;511.05199854270535;511.8694732843101;525.0601423452055;530.0856023359673;463.56193397239286;548.9451054894558;566.0179588414098;567.7643777832236;616.9321374648785;8055.355571554262;8194.50832950025;8232;8256.793580160544;8270.8345833083;506.5086865740226;526.457748519026;592.7184587320988;598.2103623217398;610.5512448350458;3852.9614703853163;3946.723729338976;4003.5996400360314;4031.314676505001;4117.875686395691;99198;99341.50329248451;99676.5016174929;102465;102782.48608756908;87816.12183878207;89366;89625;90245.54877225572;91286;60745.39254607486;63203;72857.6357118211;74379;75909.24090759242;8107.3108785753875;8196.180381961756;8221.424500284922;8557.272631826365;8872.245859101791;30344.289827255066;31100.22249443782;42119.36820947749;42666.360004600574;42929;55883.16175257456;56149.15776263278;60312.39687603068;61587;61654.38345616666;11079.667609971713;11240;11426.314421134759;11500;11642.94178529102;12455.128141030404;12740.617781466572;12787.296698681661;12895.290759008345;13915.791263131263;11844.28934263947;11994.820077699016;12119.697007574528;12164.330961797186;12469.812952805896;11107.72230694239;11327.376994265394;11424.428778561205;11529.769404611692;11859.703507412383;12113.69715757113;12183;12416.192947458387;12442.81335779946;12869.742605148032;9840;9951.950240248752;10156.74608134773;10514.78970420572;10805.189610779065;9184.402299596804;9387.624495020124;9612.231021518402;9678.322517423994;9757.951210243904 20:25:50 INFO - PROCESS | 21953 | __end_tp_report 20:25:50 INFO - PROCESS | 21953 | __start_cc_report 20:25:50 INFO - PROCESS | 21953 | _x_x_mozilla_cycle_collect,1019 20:25:50 INFO - PROCESS | 21953 | __end_cc_report 20:25:50 INFO - PROCESS | 21953 | __startTimestamp1468898750756__endTimestamp 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | ------- Summary: start ------- 20:25:50 INFO - PROCESS | 21953 | Number of tests: 6 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#0] dojo.html Cycles:165 Average:4704.83 Median:4821.95 stddev:494.16 (10.2%) stddev-sans-first:468.63 20:25:50 INFO - PROCESS | 21953 | Values: 2649.4 2660.5 2686.8 2688.1 2696.4 4472.8 4527.5 4776.1 4837.5 4878.6 4705.9 4709.0 4729.6 4734.0 4753.0 4300.4 4312.0 4379.5 4410.5 4513.5 4439.3 4443.7 4464.7 4497.3 4516.9 4257.7 4294.9 4304.8 4339.8 4414.9 4356.9 4358.6 4366.2 4366.7 4404.1 4385.3 4395.1 4396.1 4411.4 4435.4 4619.1 4691.7 4790.6 4796.7 4832.1 5057.9 5110.8 5111.7 5115.8 5167.6 5140.5 5167.1 5171.4 5178.0 5185.8 4633.9 4709.5 4751.2 4785.0 4837.1 5263.1 5277.6 5285.6 5287.0 5294.8 5069.5 5072.0 5073.8 5074.2 5080.1 4826.2 5030.1 5078.6 5079.7 5104.5 5042.2 5055.8 5063.1 5072.5 5095.1 5030.8 5037.6 5038.5 5038.7 5079.7 4257.4 4300.7 4301.0 4345.3 4390.7 3797.4 3799.5 3842.4 3864.7 3866.7 4336.2 4350.6 4356.3 4392.4 4395.8 4979.5 4989.7 5048.1 5155.9 5199.6 4275.0 4283.6 4295.4 4343.3 4343.9 4579.3 4582.3 4588.2 4591.2 4634.0 4581.4 4594.0 4749.6 4760.1 4766.0 5091.1 5130.0 5145.3 5146.1 5197.1 4810.3 4814.4 4820.1 4822.0 4873.0 4869.6 4941.7 4959.9 5061.2 5115.7 5054.7 5067.8 5071.9 5075.1 5104.0 4940.2 4940.6 4941.3 4945.6 4968.7 4707.0 4931.8 4973.6 4988.5 4992.4 4915.9 4930.1 4952.6 4996.5 5002.5 5054.7 5063.4 5068.2 5070.0 5131.4 4663.7 4806.0 4829.4 4848.1 4951.4 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#1] ext.html Cycles:180 Average:49126.26 Median:3527.41 stddev:87474.26 (2479.8%) stddev-sans-first:87643.62 20:25:50 INFO - PROCESS | 21953 | Values: 552.8 575.7 582.6 585.6 594.1 27872.4 39962.4 41131.0 41223.2 41357.0 42161.2 42896.4 42996.8 43043.0 43049.1 7462.4 7702.4 7715.0 7799.6 7949.9 7597.4 9988.0 10288.3 10289.7 10699.5 9962.8 9967.9 9987.0 9990.4 10011.1 7529.0 7758.7 10262.9 10339.1 10340.7 7739.2 7800.1 9915.0 10261.9 10268.1 40084.6 40411.8 40465.6 40498.2 40515.4 3023.5 3050.4 3080.0 3115.8 3474.4 30596.4 31063.0 31081.2 31117.0 32398.8 3400.7 3515.3 3517.4 3537.5 3575.0 267888.0 268128.0 268140.7 268376.0 268390.0 55658.0 55705.4 55808.7 56037.7 56041.0 59032.4 59253.0 59293.7 59299.0 59352.4 15432.5 15858.2 15859.6 15862.2 15868.1 10581.7 10804.1 10812.0 11543.7 11880.6 16595.8 16706.9 17173.1 17331.2 17466.3 5774.2 5836.7 5941.7 5951.5 5992.9 815.4 824.9 961.4 1031.1 1038.0 26709.3 28735.7 29124.6 29371.9 29513.4 975.6 995.8 1018.7 1026.5 1030.7 14744.2 15209.6 15249.8 15397.6 15544.3 394544.0 395289.0 398271.0 399435.0 399815.0 50852.2 50987.7 51038.7 51100.7 51177.7 1085.9 1122.4 1157.5 1167.8 1219.9 26801.7 29993.0 30368.4 30665.4 31008.4 44360.6 44874.8 44882.0 44898.0 44910.0 318532.0 319288.0 319555.0 319663.0 321056.0 24806.3 25430.1 25927.9 25970.1 27379.6 43054.6 43281.6 43514.0 44175.3 44571.3 36938.3 37837.6 38174.4 38256.6 38505.0 36924.3 36948.3 37453.6 37577.4 37905.2 34364.0 34728.3 34977.3 36644.6 37033.0 31779.4 33156.0 33717.0 34072.5 34101.5 25767.5 25867.2 25927.7 26037.3 26074.6 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#2] jquery.html Cycles:180 Average:24282.43 Median:46440.64 stddev:64981.01 (139.9%) stddev-sans-first:65138.44 20:25:50 INFO - PROCESS | 21953 | Values: 340.9 370.9 375.7 375.9 392.8 13137.7 16392.2 16714.2 17509.5 18349.2 17454.7 17600.9 17660.7 17884.1 18251.0 5096.8 5250.7 5578.6 5585.3 5680.4 3479.8 5183.9 5446.6 5467.0 5482.6 5488.1 5512.9 5517.2 5528.8 5536.8 5293.3 5566.9 5567.9 5570.0 5572.0 5291.3 5359.2 5362.2 5370.3 5387.5 12667.4 12763.7 12819.0 12896.4 12921.9 1914.6 1965.7 1990.7 2096.4 2450.8 9335.4 9373.5 9392.6 9804.4 9875.9 1652.4 1663.7 1672.9 1737.4 1758.2 65573.7 68993.3 69104.3 70727.0 71139.0 9240.0 9523.4 9844.4 9975.9 10205.7 12670.9 13241.5 13276.5 13337.1 13758.4 7187.7 7518.0 7668.3 7731.1 7780.0 7037.3 7170.3 7268.2 7283.0 7528.1 4250.2 4256.1 4352.4 4374.5 4390.4 1794.8 1833.8 1840.5 1895.6 1902.7 779.7 812.8 839.2 926.0 949.8 16841.7 17409.5 17599.3 17670.7 17837.2 830.1 859.3 862.3 871.5 888.2 9371.0 9706.4 9809.2 9814.7 9994.2 389158.0 391400.0 393152.0 394890.0 397041.0 80294.2 80944.0 81621.0 81704.6 82156.0 901.7 917.9 919.3 933.3 933.9 15349.2 15535.9 15568.7 15626.5 15919.2 29040.4 31097.0 37361.0 38135.8 39354.8 45729.5 47151.8 50647.0 51539.7 51969.2 7615.8 7701.7 7798.4 7984.7 8043.2 11869.2 12259.6 12294.8 12314.6 12380.4 10423.8 10554.4 10752.8 10821.4 10969.6 10379.4 10460.1 10547.1 10608.5 10760.9 5414.9 10685.6 10725.4 10876.4 11114.3 7707.9 7799.7 7802.4 7905.1 7989.0 8258.2 10270.4 10752.8 10888.7 11026.9 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#3] mootools.html Cycles:180 Average:5179.79 Median:5296.86 stddev:2916.34 (55.1%) stddev-sans-first:2910.37 20:25:50 INFO - PROCESS | 21953 | Values: 1357.3 1400.3 1453.2 1663.3 1686.1 7599.9 8065.9 8133.8 8151.9 8163.8 6687.0 7583.7 7788.7 7792.9 7989.0 2215.0 2251.6 2251.8 2252.3 2258.4 1872.1 2133.9 2148.7 2231.1 2232.7 2139.3 2220.3 2225.9 2239.8 2242.6 2070.8 2124.3 2125.7 2128.0 2181.1 2180.6 2184.1 2186.8 2186.9 2188.1 8072.5 8100.0 8105.3 8109.0 8116.7 4633.0 4754.9 4809.6 4810.9 4812.2 2850.2 2852.4 2998.2 3006.0 3007.1 814.7 833.6 834.0 834.5 837.6 10634.7 10637.6 10637.8 10725.1 10747.9 4185.4 4307.4 4455.0 4457.8 4458.8 8987.4 9059.0 9120.1 9125.1 9132.9 4652.0 4652.3 4653.6 4666.2 4668.8 4210.4 4276.5 4281.1 4282.7 4286.6 3428.9 3493.2 3545.9 3559.8 3569.4 987.8 1082.7 1086.3 1094.7 1113.2 698.5 812.8 858.2 861.5 895.0 5178.3 5244.6 5253.7 5446.1 5506.6 425.4 434.8 440.3 443.9 606.3 3481.3 3783.8 3795.7 3808.3 3843.2 9382.0 9835.8 9915.9 9932.9 9944.7 8318.7 9110.5 9461.5 9477.9 9707.0 7294.6 7363.9 7383.9 7388.0 7399.0 5340.0 5376.7 5388.0 5547.4 5624.8 8857.2 8883.7 9008.3 9014.0 9026.7 8812.6 9057.8 9100.3 9145.2 9183.8 6999.8 7080.0 7105.3 7113.0 7114.1 7585.1 7653.4 7660.6 7676.0 7687.9 6685.8 6794.3 6800.4 6926.3 6955.1 6529.4 6652.9 6723.7 6758.6 6780.4 6378.4 6450.7 6451.8 6456.7 6469.5 4361.7 4612.2 4652.7 4666.5 4721.2 4580.5 4612.5 4668.6 4695.2 4756.0 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#4] prototype.html Cycles:180 Average:4270.20 Median:4879.65 stddev:1248.30 (25.6%) stddev-sans-first:1215.63 20:25:50 INFO - PROCESS | 21953 | Values: 295.5 296.9 302.0 311.1 311.7 4944.5 4973.8 4984.4 4994.5 5001.9 4663.3 4775.0 4788.3 4797.4 4912.6 3750.4 3801.0 3805.7 3889.6 3904.5 3857.7 3865.7 3886.6 3893.3 3899.8 3603.2 3771.4 3844.4 3863.7 3863.9 3787.1 3801.1 3805.7 3810.1 3815.2 3336.1 3338.9 3346.8 3348.7 3357.9 4713.5 4765.8 4802.9 4806.5 4819.7 4107.7 4340.9 4363.7 4372.8 4383.2 5123.2 5134.4 5145.7 5151.6 5156.6 3650.2 3662.9 3664.4 3665.9 3670.6 5135.7 5372.8 5377.1 5392.7 5395.2 3696.5 3714.7 3722.1 3726.0 3731.9 3763.4 3766.8 3770.4 3774.0 3774.2 4307.7 4309.2 4320.8 4323.1 4323.5 4842.6 5155.3 5159.2 5165.3 5173.9 1241.0 1289.7 1307.2 1308.4 1310.1 862.5 893.7 895.2 895.3 903.5 4412.9 4421.7 4428.0 4438.9 4440.0 5253.4 5259.2 5260.8 5261.9 5272.9 4313.7 4401.8 4421.7 4434.8 4440.0 2774.8 2779.9 2791.6 2799.2 2805.8 4927.9 4934.9 4939.7 4947.8 4959.4 5174.5 5365.7 5434.3 5501.7 5513.3 5025.1 5039.4 5040.8 5042.9 5047.6 5218.3 5365.9 5367.7 5376.5 5382.3 5255.4 5271.8 5272.4 5280.5 5288.0 5020.8 5023.8 5045.7 5052.6 5053.4 3739.4 3750.3 3754.3 3754.9 3758.8 5069.5 5335.5 5347.4 5348.3 5360.5 5164.4 5168.0 5170.6 5179.4 5196.1 4940.0 5175.9 5184.9 5184.9 5193.4 4846.7 4959.6 5112.3 5128.5 5143.6 5227.7 5234.3 5239.8 5253.7 5271.2 5121.4 5127.8 5128.2 5138.5 5139.6 20:25:50 INFO - PROCESS | 21953 | 20:25:50 INFO - PROCESS | 21953 | [#5] yui.html Cycles:180 Average:17640.59 Median:505.14 stddev:25259.72 (5000.5%) stddev-sans-first:25298.25 20:25:50 INFO - PROCESS | 21953 | Values: 618.5 658.8 660.9 675.3 698.1 12367.0 13713.0 14012.2 14415.2 14481.8 14906.5 15011.5 15039.1 15117.5 15127.6 622.7 746.5 772.8 785.1 790.7 783.7 788.0 789.7 790.4 791.1 833.2 833.8 834.4 834.9 834.9 647.7 659.5 662.3 669.5 826.3 588.4 605.1 608.6 609.7 610.3 12844.2 12858.4 12859.9 12866.8 12866.9 12290.9 12656.2 12668.4 12728.3 12763.9 11753.9 11801.2 11911.2 12025.0 12044.1 4162.7 4243.1 4245.7 4255.4 4304.1 59373.1 59639.7 59877.0 59933.0 59994.0 9938.7 10019.8 10032.8 10420.6 10586.7 17329.9 17334.2 17335.3 17361.5 17636.5 6968.9 7107.0 7210.1 7273.1 7301.0 3733.4 3781.3 3802.8 3834.1 3865.5 2794.0 2915.2 2917.8 2919.3 2919.3 503.8 511.1 511.9 525.1 530.1 463.6 548.9 566.0 567.8 616.9 8055.4 8194.5 8232.0 8256.8 8270.8 506.5 526.5 592.7 598.2 610.6 3853.0 3946.7 4003.6 4031.3 4117.9 99198.0 99341.5 99676.5 102465.0 102782.5 87816.1 89366.0 89625.0 90245.5 91286.0 60745.4 63203.0 72857.6 74379.0 75909.2 8107.3 8196.2 8221.4 8557.3 8872.2 30344.3 31100.2 42119.4 42666.4 42929.0 55883.2 56149.2 60312.4 61587.0 61654.4 11079.7 11240.0 11426.3 11500.0 11642.9 12455.1 12740.6 12787.3 12895.3 13915.8 11844.3 11994.8 12119.7 12164.3 12469.8 11107.7 11327.4 11424.4 11529.8 11859.7 12113.7 12183.0 12416.2 12442.8 12869.7 9840.0 9952.0 10156.7 10514.8 10805.2 9184.4 9387.6 9612.2 9678.3 9758.0 20:25:50 INFO - PROCESS | 21953 | -------- Summary: end -------- 20:25:50 INFO - PROCESS | 21953 | 20:25:51 INFO - TEST-INFO | 21953: exit 0 20:25:51 INFO - TEST-OK | dromaeo_css | took 1119944ms 20:25:51 INFO - TEST-START | kraken 20:25:51 INFO - operating with platform_type : linux_ 20:25:51 INFO - Initialising browser for kraken test... 20:25:51 INFO - TEST-INFO | started process 22145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFCCif/profile http://localhost:44249/getInfo.html) 20:25:55 INFO - PROCESS | 22145 | __metrics Screen width/height:1600/1200 20:25:55 INFO - PROCESS | 22145 | colorDepth:24 20:25:55 INFO - PROCESS | 22145 | Browser inner width/height: 1024/697 20:25:55 INFO - PROCESS | 22145 | __metrics 20:25:56 INFO - PROCESS | 22145 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:25:56 INFO - PROCESS | 22145 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:57 INFO - TEST-INFO | 22145: exit 0 20:25:57 INFO - Browser initialized. 20:25:57 INFO - Running cycle 1/1 for kraken test... 20:25:57 INFO - TEST-INFO | started process 22226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFCCif/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:09 INFO - PROCESS | 22226 | RSS: Main: 158814208 20:26:09 INFO - PROCESS | 22226 | 20:26:12 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44249/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:12 INFO - PROCESS | 22226 | RSS: Main: 218750976 20:26:12 INFO - PROCESS | 22226 | 20:26:15 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44249/tests/kraken/driver.html?testName=audio-dft) 20:26:16 INFO - PROCESS | 22226 | RSS: Main: 207048704 20:26:16 INFO - PROCESS | 22226 | 20:26:19 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44249/tests/kraken/driver.html?testName=audio-fft) 20:26:20 INFO - PROCESS | 22226 | RSS: Main: 270770176 20:26:20 INFO - PROCESS | 22226 | 20:26:22 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44249/tests/kraken/driver.html?testName=audio-oscillator) 20:26:22 INFO - PROCESS | 22226 | RSS: Main: 182317056 20:26:22 INFO - PROCESS | 22226 | 20:26:25 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:25 INFO - PROCESS | 22226 | RSS: Main: 186560512 20:26:25 INFO - PROCESS | 22226 | 20:26:28 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44249/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:29 INFO - PROCESS | 22226 | RSS: Main: 222285824 20:26:29 INFO - PROCESS | 22226 | 20:26:32 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44249/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:33 INFO - PROCESS | 22226 | RSS: Main: 218320896 20:26:33 INFO - PROCESS | 22226 | 20:26:36 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44249/tests/kraken/driver.html?testName=json-parse-financial) 20:26:37 INFO - PROCESS | 22226 | RSS: Main: 220794880 20:26:37 INFO - PROCESS | 22226 | 20:26:38 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:39 INFO - PROCESS | 22226 | RSS: Main: 210731008 20:26:39 INFO - PROCESS | 22226 | 20:26:41 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:41 INFO - PROCESS | 22226 | RSS: Main: 215609344 20:26:41 INFO - PROCESS | 22226 | 20:26:44 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:44 INFO - PROCESS | 22226 | RSS: Main: 212770816 20:26:44 INFO - PROCESS | 22226 | 20:26:47 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:48 INFO - PROCESS | 22226 | RSS: Main: 226115584 20:26:48 INFO - PROCESS | 22226 | 20:26:50 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:51 INFO - PROCESS | 22226 | RSS: Main: 225849344 20:26:51 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | Cycle 1(1): loaded http://localhost:44249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44249/tests/kraken/driver.html?testName=ai-astar) 20:26:53 INFO - PROCESS | 22226 | RSS: Main: 268263424 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | __start_tp_report 20:26:53 INFO - PROCESS | 22226 | _x_x_mozilla_page_load 20:26:53 INFO - PROCESS | 22226 | _x_x_mozilla_page_load_details 20:26:53 INFO - PROCESS | 22226 | |i|pagename|runs| 20:26:53 INFO - PROCESS | 22226 | |0;ai-astar;104;115;115;115;114;115;112;112;115;114 20:26:53 INFO - PROCESS | 22226 | |1;audio-beat-detection;150;124;124;183;123;123;149;123;166;121 20:26:53 INFO - PROCESS | 22226 | |2;audio-dft;160;161;160;161;161;161;160;162;160;162 20:26:53 INFO - PROCESS | 22226 | |3;audio-fft;76;77;75;105;76;76;76;76;99;75 20:26:53 INFO - PROCESS | 22226 | |4;audio-oscillator;86;85;119;84;86;85;115;85;85;139 20:26:53 INFO - PROCESS | 22226 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 20:26:53 INFO - PROCESS | 22226 | |6;imaging-darkroom;152;146;147;147;146;145;146;147;146;146 20:26:53 INFO - PROCESS | 22226 | |7;imaging-desaturate;94;95;96;95;95;95;95;96;95;95 20:26:53 INFO - PROCESS | 22226 | |8;json-parse-financial;63;62;61;63;63;63;62;62;63;63 20:26:53 INFO - PROCESS | 22226 | |9;json-stringify-tinderbox;67;66;66;67;67;66;65;66;67;65 20:26:53 INFO - PROCESS | 22226 | |10;stanford-crypto-aes;79;78;78;78;88;81;84;78;78;85 20:26:53 INFO - PROCESS | 22226 | |11;stanford-crypto-ccm;140;129;132;127;128;130;133;135;176;141 20:26:53 INFO - PROCESS | 22226 | |12;stanford-crypto-pbkdf2;168;165;161;165;165;166;164;165;166;161 20:26:53 INFO - PROCESS | 22226 | |13;stanford-crypto-sha256-iterative;67;68;68;65;66;66;66;70;64;66 20:26:53 INFO - PROCESS | 22226 | __end_tp_report 20:26:53 INFO - PROCESS | 22226 | __start_cc_report 20:26:53 INFO - PROCESS | 22226 | _x_x_mozilla_cycle_collect,1960 20:26:53 INFO - PROCESS | 22226 | __end_cc_report 20:26:53 INFO - PROCESS | 22226 | __startTimestamp1468898813574__endTimestamp 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | ------- Summary: start ------- 20:26:53 INFO - PROCESS | 22226 | Number of tests: 14 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:3.41 (3.0%) stddev-sans-first:1.27 20:26:53 INFO - PROCESS | 22226 | Values: 104.0 115.0 115.0 115.0 114.0 115.0 112.0 112.0 115.0 114.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:136.50 stddev:22.18 (16.2%) stddev-sans-first:23.14 20:26:53 INFO - PROCESS | 22226 | Values: 150.0 124.0 124.0 183.0 123.0 123.0 149.0 123.0 166.0 121.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 20:26:53 INFO - PROCESS | 22226 | Values: 160.0 161.0 160.0 161.0 161.0 161.0 160.0 162.0 160.0 162.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.12 (14.6%) stddev-sans-first:11.64 20:26:53 INFO - PROCESS | 22226 | Values: 76.0 77.0 75.0 105.0 76.0 76.0 76.0 76.0 99.0 75.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.89 (23.4%) stddev-sans-first:20.70 20:26:53 INFO - PROCESS | 22226 | Values: 86.0 85.0 119.0 84.0 86.0 85.0 115.0 85.0 85.0 139.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:26:53 INFO - PROCESS | 22226 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.93 (1.3%) stddev-sans-first:0.67 20:26:53 INFO - PROCESS | 22226 | Values: 152.0 146.0 147.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 20:26:53 INFO - PROCESS | 22226 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 20:26:53 INFO - PROCESS | 22226 | Values: 63.0 62.0 61.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 20:26:53 INFO - PROCESS | 22226 | Values: 67.0 66.0 66.0 67.0 67.0 66.0 65.0 66.0 67.0 65.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.68 (4.6%) stddev-sans-first:3.86 20:26:53 INFO - PROCESS | 22226 | Values: 79.0 78.0 78.0 78.0 88.0 81.0 84.0 78.0 78.0 85.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:134.00 stddev:14.47 (10.8%) stddev-sans-first:15.31 20:26:53 INFO - PROCESS | 22226 | Values: 140.0 129.0 132.0 127.0 128.0 130.0 133.0 135.0 176.0 141.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:2.17 (1.3%) stddev-sans-first:1.92 20:26:53 INFO - PROCESS | 22226 | Values: 168.0 165.0 161.0 165.0 165.0 166.0 164.0 165.0 166.0 161.0 20:26:53 INFO - PROCESS | 22226 | 20:26:53 INFO - PROCESS | 22226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.71 (2.6%) stddev-sans-first:1.81 20:26:53 INFO - PROCESS | 22226 | Values: 67.0 68.0 68.0 65.0 66.0 66.0 66.0 70.0 64.0 66.0 20:26:53 INFO - PROCESS | 22226 | -------- Summary: end -------- 20:26:53 INFO - PROCESS | 22226 | 20:26:54 INFO - TEST-INFO | 22226: exit 0 20:26:54 INFO - TEST-OK | kraken | took 63083ms 20:26:54 INFO - SUITE-END | took 1183s 20:26:54 INFO - Completed test suite (00:19:43) 20:26:54 INFO - javascript benchmark 20:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.4436168404636, 2660.4812061647986, 2686.8119231653786, 2688.1129227354977, 2696.447228318195, 4472.753998530079, 4527.501974782771, 4776.140294746949, 4837.516248375161, 4878.634102442314, 4705.85882423527, 4709.0346478971815, 4729.574338309551, 4733.976330118345, 4753.0493901219725, 4300.419443375135, 4311.978440107795, 4379.4963579188325, 4410.536893626171, 4513.52607976161, 4439.334099885011, 4443.666724995622, 4464.6874718769695, 4497.257952437843, 4516.864494065183, 4257.723247988871, 4294.871153865389, 4304.80628371724, 4339.761313127777, 4414.889627759299, 4356.912861742779, 4358.585934336233, 4366.19225443294, 4366.6506679465565, 4404.0531285773395, 4385.342198670225, 4395.142947125312, 4396.098799746044, 4411.404460397837, 4435.423394958667, 4619.076184763027, 4691.741954192518, 4790.568848803624, 4796.664233503656, 4832.057748738997, 5057.898842023175, 5110.795568177268, 5111.667741596784, 5115.820946266863, 5167.612429067835, 5140.485951404867, 5167.069927413064, 5171.4311425743135, 5178.042062218502, 5185.766640501187, 4633.8841528961375, 4709.458412282632, 4751.192297309466, 4784.952150478521, 4837.105135549899, 5263.052650522943, 5277.577793776489, 5285.630005899627, 5287.048331300326, 5294.7617357219015, 5069.493050694901, 5072.036313100499, 5073.797048118107, 5074.16276314404, 5080.13637681595, 4826.203676393356, 5030.119729047402, 5078.5937125029905, 5079.72061536619, 5104.464031276662, 5042.193249080129, 5055.823046193365, 5063.13926632466, 5072.492750724972, 5095.082885080721, 5030.798768049311, 5037.622178336566, 5038.546530812245, 5038.672486288379, 5079.72061536619, 4257.3613957905945, 4300.65594752419, 4301.0, 4345.283028300359, 4390.714603550823, 3797.430385442206, 3799.525059367579, 3842.404427313715, 3864.652181303696, 3866.6713329367317, 4336.1978034063795, 4350.564943505624, 4356.346548017759, 4392.38506609075, 4395.802188901507, 4979.45226025137, 4989.675671081368, 5048.1418158913075, 5155.922661160085, 5199.584033277329, 4275.0381164238415, 4283.571642835692, 4295.398644189816, 4343.3484977253665, 4343.9348409773875, 4579.267317229227, 4582.289745089516, 4588.220002599566, 4591.150637132141, 4634.0, 4581.381513495636, 4593.954060459353, 4749.596284315734, 4760.143174228672, 4766.046790641816, 5091.0836049511445, 5129.9743501282255, 5145.279660847559, 5146.125158722951, 5197.142471492161, 4810.326554282473, 4814.446338670958, 4820.132376172322, 4821.951780482291, 4873.049755297683, 4869.586085182799, 4941.654084214214, 4959.851204463872, 5061.215511595708, 5115.744212789271, 5054.69671819692, 5067.797288108434, 5071.923921141112, 5075.086484432837, 5104.0, 4940.209566469348, 4940.60475161979, 4941.2835138905375, 4945.629077819106, 4968.701877887338, 4706.976465117653, 4931.753412329297, 4973.6269779765935, 4988.501149884983, 4992.425871024733, 4915.926261106015, 4930.063287975273, 4952.57903078228, 4996.475370086088, 5002.499750025114, 5054.721990290569, 5063.392392912874, 5068.189089745623, 5069.9746501267255, 5131.358580177478, 4663.696859704109, 4805.975970120127, 4829.44461386945, 4848.0788650156355, 4951.356323678043], "value": 4673.650763241905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7864183187796, 575.7380391921677, 582.5572564850713, 585.5959388022262, 594.0584174084075, 27872.44255114899, 39962.40056399156, 41131.0, 41223.17553648925, 41357.0, 42161.156776864445, 42896.356554651706, 42996.78501607488, 43043.0, 43049.13901721971, 7462.365698915599, 7702.42231832612, 7715.0, 7799.571023593714, 7949.920500794976, 7597.430192735539, 9987.950060249725, 10288.331258468213, 10289.691309260734, 10699.518521666505, 9962.750931226705, 9967.90032099677, 9987.0, 9990.400575965465, 10011.14905233056, 7528.999999999945, 7758.650860711282, 10262.948685256562, 10339.0694837465, 10340.741481462948, 7739.187385324516, 7800.141984381714, 9914.9504252479, 10261.897381026243, 10268.100401425685, 40084.59915400867, 40411.7979410104, 40465.59534404677, 40498.190036199405, 40515.39226911599, 3023.5011223148153, 3050.4051709916575, 3079.9846000770076, 3115.79747316426, 3474.409350410436, 30596.388072238653, 31063.0, 31081.22296942572, 31117.0, 32398.83800580982, 3400.7449441292, 3515.2793677296095, 3517.3668739626855, 3537.451694987281, 3574.964250357515, 267888.0, 268128.0, 268140.6592967042, 268376.0, 268390.0, 55658.0, 55705.44294557084, 55808.72095639496, 56037.7198114015, 56041.0, 59032.40967590355, 59253.0, 59293.70353148207, 59299.0, 59352.40647593469, 15432.459863904709, 15858.207089645472, 15859.603509912344, 15862.206889655472, 15868.127253000965, 10581.682549523526, 10804.13566914645, 10812.0, 11543.711407214887, 11880.584179553847, 16595.83404165967, 16706.916465417595, 17173.141342932802, 17331.220095095752, 17466.30134794594, 5774.220480235199, 5836.678982655994, 5941.722529656145, 5951.464368206882, 5992.910106348409, 815.3762371785589, 824.9298809601131, 961.4423634292094, 1031.0823367203195, 1037.9532921018572, 26709.332266693098, 28735.712642873303, 29124.563131553045, 29371.853140734158, 29513.409731805245, 975.5902520941222, 995.8058178655093, 1018.7147598672384, 1026.5329275179774, 1030.701096681969, 14744.189069601274, 15209.6197595061, 15249.772164758504, 15397.615059623375, 15544.300506477235, 394544.0, 395289.0, 398271.0, 399435.0, 399815.0, 50852.23721644178, 50987.74506127446, 51038.74480627573, 51100.74449627728, 51177.74411127921, 1085.8914108589079, 1122.3602546548552, 1157.5080590749067, 1167.8073117935614, 1219.890209881115, 26801.659917003682, 29993.0, 30368.392632147676, 30665.386692266475, 31008.379832402774, 44360.55639443564, 44874.775626121664, 44882.0, 44898.0, 44910.0, 318532.0, 319288.0, 319555.0, 319663.0, 321056.0, 24806.25581232566, 25430.109946152537, 25927.870360648078, 25970.09104681327, 27379.589306160025, 43054.569454305056, 43281.56718432775, 43514.0, 44175.33736993883, 44571.33143002792, 36938.261234775695, 37837.62162378341, 38174.427383588714, 38256.617433825304, 38505.0, 36924.26151477009, 36948.261034779694, 37453.62546374501, 37577.4363384544, 37905.24189516139, 34364.0, 34728.305433891685, 34977.30045399129, 36644.63355366412, 37033.0, 31779.36441271208, 33156.0, 33717.0, 34072.48891266583, 34101.488477672356, 25767.484650307262, 25867.22398328053, 25927.74072259253, 26037.349066273495, 26074.60888086718], "value": 18280.67337605189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.909658940381, 370.92396058807947, 375.7088256601136, 375.93421151298514, 392.8055612471827, 13137.67155821105, 16392.180390980448, 16714.164291785393, 17509.474715758515, 18349.174287157075, 17454.738178927328, 17600.911995440038, 17660.735088973677, 17884.105794710278, 18251.0, 5096.847094587159, 5250.737463126848, 5578.609497335168, 5585.301837270341, 5680.375158732557, 3479.8260086995674, 5183.948160518403, 5446.591505637073, 5467.043267428204, 5482.588805839558, 5488.067028605126, 5512.862178445551, 5517.227588137664, 5528.806491772789, 5536.778528858841, 5293.285406470135, 5566.86082847928, 5567.944320556783, 5570.0, 5571.9721401392935, 5291.28567643367, 5359.169328754049, 5362.249285100089, 5370.301860758115, 5387.488188622075, 12667.36663166838, 12763.680907977281, 12819.038572107129, 12896.355182240944, 12921.935390322988, 1914.5979344337707, 1965.744453221072, 1990.6814909614393, 2096.371088673392, 2450.7916827069544, 9335.439873607538, 9373.531323433801, 9392.577334019985, 9804.36271642348, 9875.851862222073, 1652.3638399216268, 1663.69221693987, 1672.8912620679616, 1737.444017914268, 1758.2439550993067, 65573.67213163903, 68993.3100668992, 69104.30895691029, 70727.0, 71138.99999999948, 9239.953800231091, 9523.380980236263, 9844.3601165924, 9975.850362244571, 10205.693829185137, 12670.936645316715, 13241.536546221028, 13276.53532126371, 13337.066405351727, 13758.449662013607, 7187.748428804966, 7517.962410187914, 7668.309852113337, 7731.110922244014, 7780.02749656293, 7037.331453511908, 7170.318819712119, 7268.23683513234, 7283.016792732913, 7528.134264559536, 4250.192463431938, 4256.1487702459635, 4352.39066530686, 4374.4531933508315, 4390.385346051556, 1794.8115447878047, 1833.7524434201212, 1840.5398650337415, 1895.6303520813585, 1902.6670332691724, 779.6959185917497, 812.8049268175713, 839.1608391608391, 925.9629215278931, 949.7897107775811, 16841.6631667366, 17409.47771566855, 17599.296028158988, 17670.674699397598, 17837.197326120357, 830.1449507007792, 859.3168431097292, 862.2929198057533, 871.4945331707721, 888.1961824548794, 9370.95314523423, 9706.369086009387, 9809.21526277896, 9814.705558833246, 9994.20046396301, 389158.0, 391400.0, 393152.0, 394890.0, 397041.0, 80294.19705802984, 80944.0, 81621.0, 81704.59147704224, 82156.0, 901.7384958362132, 917.9311551633655, 919.2508105893676, 933.2533972821716, 933.869258303838, 15349.232538372813, 15535.922320388325, 15568.688626227638, 15626.45307414235, 15919.204039798195, 29040.41919161647, 31097.045780650802, 37361.0, 38135.809320953216, 39354.803225983684, 45729.51245850519, 47151.764241179946, 50647.0, 51539.742301289756, 51969.22046169386, 7615.809604759926, 7701.730439434593, 7798.376129909707, 7984.720534781255, 8043.1554686757045, 11869.21677958322, 12259.570915017932, 12294.81557776652, 12314.568990085305, 12380.4428800706, 10423.791524169626, 10554.366737995744, 10752.784944300915, 10821.350718956888, 10969.561217551209, 10379.429131397543, 10460.110890574386, 10547.103496202908, 10608.522616482123, 10760.892391076302, 5414.944085903211, 10685.626003089854, 10725.356478611307, 10876.401797901191, 11114.333140011626, 7707.884381734167, 7799.688012479664, 7802.414818888493, 7905.130435652189, 7988.960055199686, 8258.174182581934, 10270.43512606784, 10752.838707419238, 10888.67333979982, 11026.889731102587], "value": 8173.504436056577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.3349058961112, 1400.3488377904275, 1453.2080016391067, 1663.2764747334918, 1686.0979376033818, 7599.886001709971, 8065.91934080659, 8133.796655083626, 8151.91848081519, 8163.836723265538, 6687.0, 7583.658735356908, 7788.688452461909, 7792.92207077929, 7989.0, 2214.966775498369, 2251.6284813005836, 2251.8311126665485, 2252.3468194223656, 2258.4015235962484, 1872.129459801199, 2133.925312614059, 2148.709924160242, 2231.0852550454315, 2232.720909886264, 2139.3474990128007, 2220.2784095169054, 2225.899834507451, 2239.8096161826265, 2242.6075436798496, 2070.7618623858298, 2124.2671278408925, 2125.744910610721, 2128.0423809285808, 2181.1057466438842, 2180.6401943679275, 2184.0936011555186, 2186.8250539956766, 2186.8797216153107, 2188.0919418441326, 8072.515649061075, 8099.959500202462, 8105.27052565272, 8108.9594552026865, 8116.715914942949, 4633.0, 4754.904901901942, 4809.567138957511, 4810.855674329776, 4812.230043193073, 2850.2161905475955, 2852.415254872746, 2998.220462679697, 3006.038067818299, 3007.0678089792236, 814.6782021101632, 833.5665453963966, 834.045018453873, 834.5076404921126, 837.5853952293593, 10634.734131646694, 10637.627683031134, 10637.829838717735, 10725.141988640968, 10747.946260268727, 4185.3931179979345, 4307.440032795716, 4455.04216593434, 4457.799399026987, 4458.8439404620685, 8987.370884038055, 9058.954705226432, 9120.087991200828, 9125.087491250822, 9132.908670913206, 4651.953480465152, 4652.302154676826, 4653.60444362233, 4666.2067448533835, 4668.8132474701315, 4210.431591735138, 4276.465441819772, 4281.05816720321, 4282.678799090018, 4286.592773686495, 3428.9314213715584, 3493.1965647901125, 3545.858165673396, 3559.8430510084327, 3569.39320315547, 987.807377561383, 1082.7130810335268, 1086.2830531848942, 1094.698957786615, 1113.2207454781685, 698.4866123399297, 812.8496228197803, 858.1890113842484, 861.4529773593688, 894.9910500894907, 5178.300929374562, 5244.554212891947, 5253.737313134328, 5446.074167391553, 5506.614536982453, 425.4447945431242, 434.81303039693233, 440.28673548851066, 443.9178751930903, 606.3239487970969, 3481.2689335239884, 3783.810809459516, 3795.7153213509096, 3808.257389808961, 3843.1737176507186, 9381.953090234505, 9835.754106147404, 9915.851262231072, 9932.851007234898, 9944.651937182309, 8318.70884519039, 9110.498922559324, 9461.479618621042, 9477.905220947703, 9707.029297070236, 7294.635268236567, 7363.889541656879, 7383.9261607384315, 7387.963060184772, 7398.999999999893, 5339.973300133474, 5376.73116344189, 5388.0, 5547.41752116022, 5624.803131890364, 8857.202851743374, 8883.689070882489, 9008.32437567172, 9014.0, 9026.684066057656, 8812.64749410042, 9057.77355566116, 9100.31747618918, 9145.176934075966, 9183.816323673356, 6999.790006299819, 7080.0, 7105.28947105306, 7113.0, 7114.14630244374, 7585.127710313164, 7653.387728981556, 7660.578668173304, 7675.961620191863, 7687.88468172989, 6685.832854178684, 6794.320567943166, 6800.421964132906, 6926.272741362084, 6955.061066755923, 6529.379708927644, 6652.866942661023, 6723.731050757915, 6758.628275444898, 6780.38976492118, 6378.425941665272, 6450.677466126581, 6451.806445806634, 6456.677166141768, 6469.482441404771, 4361.694681372401, 4612.238980568303, 4652.697574657636, 4666.533346665306, 4721.150192965162, 4580.519045500175, 4612.53874612536, 4668.6498512611015, 4695.154872123051, 4756.048790241896], "value": 4090.8355441803433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.47700569991116, 296.94654962106813, 302.0289768394611, 311.0978163326352, 311.7303532444436, 4944.456109827921, 4973.801047958086, 4984.352034235549, 4994.525520075587, 5001.874953126169, 4663.347131401598, 4775.0, 4788.281757736341, 4797.376341075656, 4912.606991440685, 3750.4374343848367, 3801.0497375656155, 3805.676517496016, 3889.611038896102, 3904.4728961590104, 3857.6528112469873, 3865.729398942075, 3886.5724770275247, 3893.260280546687, 3899.7660140391667, 3603.171270607762, 3771.41543060826, 3844.4233364995193, 3863.652271295583, 3863.864764733221, 3787.1289603391238, 3801.144742432958, 3805.7335986480957, 3810.12367155553, 3815.179736356669, 3336.065901547571, 3338.8998330050135, 3346.8159251241173, 3348.7153591944716, 3357.9160520986925, 4713.457952335491, 4765.809367625291, 4802.879928001793, 4806.461932181704, 4819.662623616348, 4107.691923105779, 4340.934885976713, 4363.738175709467, 4372.759498227596, 4383.167198232358, 5123.2315152727015, 5134.4095429025765, 5145.716985565792, 5151.639385243035, 5156.613254005964, 3650.1787097903025, 3662.926741465182, 3664.358737220976, 3665.9450108248398, 3670.596234414212, 5135.691858488465, 5372.811951581715, 5377.139657654796, 5392.678793695531, 5395.21769343443, 3696.500972368696, 3714.7213958953184, 3722.088088418355, 3725.962740372616, 3731.8880433587037, 3763.3790424580184, 3766.8304926277833, 3770.377887648562, 3773.981130094332, 3774.226283611908, 4307.6769242306955, 4309.159713855831, 4320.78396080201, 4323.135372925428, 4323.546027667113, 4842.564169224786, 5155.304033955443, 5159.2003239497935, 5165.276861239429, 5173.948260517347, 1241.0, 1289.7356042011365, 1307.1830106183636, 1308.3523655790254, 1310.0567591334225, 862.4911302331654, 893.7229458867772, 895.1630225738955, 895.2748273898163, 903.503073309677, 4412.889677758082, 4421.734695918255, 4427.977860110744, 4438.911221775611, 4439.955600444019, 5253.44838791929, 5259.15853463444, 5260.815871444558, 5261.921071183935, 5272.92090618641, 4313.705888233518, 4401.801918913657, 4421.668374871898, 4434.778261086997, 4439.977800110979, 2774.819636723647, 2779.88880444784, 2791.5812628105946, 2799.174243598143, 2805.789565782534, 4927.876803079952, 4934.915677701437, 4939.678920870132, 4947.826826061142, 4959.429665588431, 5174.508421699932, 5365.651232669864, 5434.266374039533, 5501.724913754297, 5513.283273174462, 5025.115581656879, 5039.395272567315, 5040.823571174918, 5042.890564075898, 5047.6214283929585, 5218.347706536683, 5365.946340536545, 5367.677939323653, 5376.462353764592, 5382.273393092039, 5255.372313842926, 5271.841844744664, 5272.446393128666, 5280.471952804689, 5288.0, 5020.7991680333835, 5023.794289370598, 5045.672031317952, 5052.5705315048635, 5053.393592768744, 3739.383001804672, 3750.343689854319, 3754.2679177560112, 3754.887353379403, 3758.8120593969647, 5069.518395752398, 5335.4527187116855, 5347.43851895561, 5348.304720386481, 5360.490753378423, 5164.406093299169, 5167.974160129175, 5170.603936936931, 5179.378474582923, 5196.142636465092, 4939.975300123477, 5175.896482070413, 5184.870378240575, 5184.896302074013, 5193.37679478465, 4846.684965477232, 4959.62802789785, 5112.309838171948, 5128.512791284822, 5143.553818941244, 5227.738613069408, 5234.319538459976, 5239.842804715865, 5253.737313134405, 5271.20931860224, 5121.385433747974, 5127.846164615067, 5128.1794912813775, 5138.537531622172, 5139.6145289102715], "value": 3874.193141627904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.4742968476795, 658.8352911772057, 660.9074729537864, 675.3078094952676, 698.0855079845406, 12367.0, 13713.0, 14012.22932738699, 14415.207163605997, 14481.78277325841, 14906.47827326041, 15011.549653510385, 15039.097654140733, 15117.54647360581, 15127.62180945477, 622.7322251431882, 746.5259560179298, 772.822250882296, 785.0775338976708, 790.6600161930368, 783.7335305995961, 788.0385929166408, 789.7354386280603, 790.4427378698033, 791.1020991175029, 833.1918039501674, 833.8332333533317, 834.3742193354984, 834.9123342049088, 834.9123342049088, 647.7182425644836, 659.4987809264993, 662.2781168526329, 669.5012215899137, 826.3182874128838, 588.3616276340176, 605.1044454207753, 608.6013661052018, 609.7439075588263, 610.2737742086903, 12844.229346239163, 12858.421371038326, 12859.871401285962, 12866.806997895039, 12866.935665321707, 12290.877091229062, 12656.17734847232, 12668.429920653592, 12728.299943503103, 12763.936180319131, 11753.882461175364, 11801.173917825756, 11911.225770324902, 12025.0, 12044.096692748079, 4162.687798415101, 4243.066525364415, 4245.681573881971, 4255.446791917062, 4304.139172165548, 59373.10940335898, 59639.701801490715, 59876.99999999956, 59933.0, 59994.0, 9938.652147174815, 10019.849702254473, 10032.799344013225, 10420.635277765241, 10586.682399528027, 17329.913350433166, 17334.219960101826, 17335.306587736348, 17361.47915562535, 17636.470905872844, 6968.930310696929, 7107.0, 7210.062691850026, 7273.12722473296, 7301.014363060919, 3733.383991641403, 3781.300459415017, 3802.752821066622, 3834.118152824866, 3865.4974853268895, 2793.9860300698774, 2915.19832046189, 2917.766578673701, 2919.299368151628, 2919.3285544324926, 503.77833753148496, 511.05199854270535, 511.8694732843101, 525.0601423452055, 530.0856023359673, 463.56193397239286, 548.9451054894558, 566.0179588414098, 567.7643777832236, 616.9321374648785, 8055.355571554262, 8194.50832950025, 8232.0, 8256.793580160544, 8270.8345833083, 506.5086865740226, 526.457748519026, 592.7184587320988, 598.2103623217398, 610.5512448350458, 3852.9614703853163, 3946.723729338976, 4003.5996400360314, 4031.314676505001, 4117.875686395691, 99198.0, 99341.50329248451, 99676.5016174929, 102465.0, 102782.48608756908, 87816.12183878207, 89366.0, 89625.0, 90245.54877225572, 91286.0, 60745.39254607486, 63203.0, 72857.6357118211, 74379.0, 75909.24090759242, 8107.3108785753875, 8196.180381961756, 8221.424500284922, 8557.272631826365, 8872.245859101791, 30344.289827255066, 31100.22249443782, 42119.36820947749, 42666.360004600574, 42929.0, 55883.16175257456, 56149.15776263278, 60312.39687603068, 61587.0, 61654.38345616666, 11079.667609971713, 11240.0, 11426.314421134759, 11500.0, 11642.94178529102, 12455.128141030404, 12740.617781466572, 12787.296698681661, 12895.290759008345, 13915.791263131263, 11844.28934263947, 11994.820077699016, 12119.697007574528, 12164.330961797186, 12469.812952805896, 11107.72230694239, 11327.376994265394, 11424.428778561205, 11529.769404611692, 11859.703507412383, 12113.69715757113, 12183.0, 12416.192947458387, 12442.81335779946, 12869.742605148032, 9840.0, 9951.950240248752, 10156.74608134773, 10514.78970420572, 10805.189610779065, 9184.402299596804, 9387.624495020124, 9612.231021518402, 9678.322517423994, 9757.951210243904], "value": 6589.868020014322, "unit": "score"}], "name": "dromaeo_css", "value": 6463.924362210353, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 115.0, 114.0, 115.0, 112.0, 112.0, 115.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 124.0, 183.0, 123.0, 123.0, 149.0, 123.0, 166.0, 121.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 105.0, 76.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 119.0, 84.0, 86.0, 85.0, 115.0, 85.0, 85.0, 139.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 66.0, 67.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 88.0, 81.0, 84.0, 78.0, 78.0, 85.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 132.0, 127.0, 128.0, 130.0, 133.0, 135.0, 176.0, 141.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 161.0, 165.0, 165.0, 166.0, 164.0, 165.0, 166.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 66.0, 66.0, 66.0, 70.0, 64.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1526.8999999999996, "alertThreshold": 2.0}]} 20:26:54 INFO - Return code: 0 20:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:54 INFO - # TBPL SUCCESS # 20:26:54 INFO - Running post-action listener: _resource_record_post_action 20:26:54 INFO - ##### 20:26:54 INFO - ##### Finished run-tests step (success) 20:26:54 INFO - ##### 20:26:54 INFO - Running post-run listener: _resource_record_post_run 20:26:54 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548585472; Read time: 184; Write time: 420128 20:26:54 INFO - TinderboxPrint: CPU usage
12.9% 20:26:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 20:26:54 INFO - TinderboxPrint: I/O write bytes / time
548,585,472 / 420,128 20:26:54 INFO - TinderboxPrint: CPU idle
8,337.4 (87.0%) 20:26:54 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 20:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246714368; Read time: 148; Write time: 243136 20:26:54 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289296384; Read time: 28; Write time: 174192 20:26:55 INFO - Running post-run listener: _upload_blobber_files 20:26:55 INFO - Blob upload gear active. 20:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:55 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 20:26:55 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:55 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:03 INFO - (blobuploader) - INFO - Done attempting. 20:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:04 INFO - (blobuploader) - INFO - Done attempting. 20:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:05 INFO - (blobuploader) - INFO - Done attempting. 20:27:05 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:05 INFO - Return code: 0 20:27:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ca349a51f600690a20f1c34c521fa2d66f35af11e3835a736205e822ecc07818a6fab9e1b57e15b9adb957bd35121f1e59f713bd56e52c731df94cf04e6608e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ca0b93413d73343fd895d0e96d1c206284a2fe23ee90d65f6bf824735630c9578f4478ec3640278fa5d9fbddbdf011f87d8d1f4dd9876c3a6d687d685a88129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/073b9ea9cf105333dfc29586718166aa2e076232724ab36ed8a90aa474e20553e021195e1c4e8ed411b6c2f2d4839e29fb9e16ef7d1fc97c70f3f658fa8ec028"} 20:27:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:05 INFO - Contents: 20:27:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ca349a51f600690a20f1c34c521fa2d66f35af11e3835a736205e822ecc07818a6fab9e1b57e15b9adb957bd35121f1e59f713bd56e52c731df94cf04e6608e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ca0b93413d73343fd895d0e96d1c206284a2fe23ee90d65f6bf824735630c9578f4478ec3640278fa5d9fbddbdf011f87d8d1f4dd9876c3a6d687d685a88129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/073b9ea9cf105333dfc29586718166aa2e076232724ab36ed8a90aa474e20553e021195e1c4e8ed411b6c2f2d4839e29fb9e16ef7d1fc97c70f3f658fa8ec028"} 20:27:05 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:05 INFO - Copying logs to upload dir... 20:27:05 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.889288 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-18 20:27:04.701904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:27:04.706337) ========= 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=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ca349a51f600690a20f1c34c521fa2d66f35af11e3835a736205e822ecc07818a6fab9e1b57e15b9adb957bd35121f1e59f713bd56e52c731df94cf04e6608e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ca0b93413d73343fd895d0e96d1c206284a2fe23ee90d65f6bf824735630c9578f4478ec3640278fa5d9fbddbdf011f87d8d1f4dd9876c3a6d687d685a88129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/073b9ea9cf105333dfc29586718166aa2e076232724ab36ed8a90aa474e20553e021195e1c4e8ed411b6c2f2d4839e29fb9e16ef7d1fc97c70f3f658fa8ec028"} build_url:https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/LTBqwQkwTrOnpqHquJv4Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ca349a51f600690a20f1c34c521fa2d66f35af11e3835a736205e822ecc07818a6fab9e1b57e15b9adb957bd35121f1e59f713bd56e52c731df94cf04e6608e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ca0b93413d73343fd895d0e96d1c206284a2fe23ee90d65f6bf824735630c9578f4478ec3640278fa5d9fbddbdf011f87d8d1f4dd9876c3a6d687d685a88129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/073b9ea9cf105333dfc29586718166aa2e076232724ab36ed8a90aa474e20553e021195e1c4e8ed411b6c2f2d4839e29fb9e16ef7d1fc97c70f3f658fa8ec028"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:27:04.731841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:27:04.732191) ========= 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=32c5991c409366f7fec8a718000001d2-1468897170.485792-2073615672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:27:04.816443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:27:04.816851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:27:04.820211) ========= ========= Total master_lag: 0.74 =========