builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1468954713.98 results: success (0) buildid: 20160719102519 builduid: a0ef3218d1fe4f56956b74c54b51f6f6 revision: 3a98a8d388330fbf63bd5123bf02e0e37b6add98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:33.981006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:33.982129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:33.982859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.001216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.001954) ========= 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-1468954713.194361-1095684040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 11:58:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.4M=0s 2016-07-19 11:58:34 (39.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.095905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.096695) ========= 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-1468954713.194361-1095684040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018268 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.150531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.151326) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3a98a8d388330fbf63bd5123bf02e0e37b6add98 --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 3a98a8d388330fbf63bd5123bf02e0e37b6add98 --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-1468954713.194361-1095684040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 11:58:34,646 truncating revision to first 12 chars 2016-07-19 11:58:34,646 Setting DEBUG logging. 2016-07-19 11:58:34,646 attempt 1/10 2016-07-19 11:58:34,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3a98a8d38833?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 11:58:35,006 unpacking tar archive at: autoland-3a98a8d38833/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.927790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.928596) ========= script_repo_revision: 3a98a8d388330fbf63bd5123bf02e0e37b6add98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.929425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.929739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 11:58:34.941139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-07-19 11:58:34.941775) ========= /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-1468954713.194361-1095684040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:58:35 INFO - MultiFileLogger online at 20160719 11:58:35 in /builds/slave/test 11:58:35 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 11:58:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:35 INFO - {'append_to_log': False, 11:58:35 INFO - 'base_work_dir': '/builds/slave/test', 11:58:35 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:58:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:35 INFO - 'branch': 'Autoland-Non-PGO', 11:58:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:35 INFO - 'config_files': ('talos/linux_config.py',), 11:58:35 INFO - 'default_actions': ('clobber', 11:58:35 INFO - 'read-buildbot-config', 11:58:35 INFO - 'download-and-extract', 11:58:35 INFO - 'populate-webroot', 11:58:35 INFO - 'create-virtualenv', 11:58:35 INFO - 'install', 11:58:35 INFO - 'run-tests'), 11:58:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:35 INFO - 'download_minidump_stackwalk': True, 11:58:35 INFO - 'download_symbols': 'ondemand', 11:58:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:35 INFO - 'installer_path': 'installer.exe', 11:58:35 INFO - 'log_level': 'info', 11:58:35 INFO - 'log_name': 'talos', 11:58:35 INFO - 'log_to_console': True, 11:58:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:58:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:58:35 INFO - 'opt_config_files': (), 11:58:35 INFO - 'pip_index': False, 11:58:35 INFO - 'sps_profile': False, 11:58:35 INFO - 'sps_profile_interval': 0, 11:58:35 INFO - 'suite': 'dromaeojs', 11:58:35 INFO - 'system_bits': '32', 11:58:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:35 INFO - 'title': 'talos-linux64-ix-008', 11:58:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:35 INFO - 'use_talos_json': True, 11:58:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:35 INFO - 'work_dir': 'build'} 11:58:35 INFO - [mozharness: 2016-07-19 18:58:35.525708Z] Running clobber step. 11:58:35 INFO - Running pre-action listener: _resource_record_pre_action 11:58:35 INFO - Running main action method: clobber 11:58:35 INFO - rmtree: /builds/slave/test/build 11:58:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:35 INFO - Running post-action listener: _resource_record_post_action 11:58:35 INFO - [mozharness: 2016-07-19 18:58:35.995044Z] Finished clobber step (success) 11:58:35 INFO - [mozharness: 2016-07-19 18:58:35.995145Z] Running read-buildbot-config step. 11:58:35 INFO - Running pre-action listener: _resource_record_pre_action 11:58:35 INFO - Running main action method: read_buildbot_config 11:58:35 INFO - Using buildbot properties: 11:58:35 INFO - { 11:58:35 INFO - "project": "", 11:58:35 INFO - "product": "firefox", 11:58:35 INFO - "script_repo_revision": "production", 11:58:35 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:58:35 INFO - "repository": "", 11:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:58:35 INFO - "buildid": "20160719102519", 11:58:35 INFO - "pgo_build": "False", 11:58:35 INFO - "basedir": "/builds/slave/test", 11:58:35 INFO - "buildnumber": 170, 11:58:35 INFO - "slavename": "talos-linux64-ix-008", 11:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:58:35 INFO - "platform": "ubuntu64_hw", 11:58:35 INFO - "scheduler": "tests-autoland-linux64-talos", 11:58:35 INFO - "branch": "autoland", 11:58:35 INFO - "repo_path": "integration/autoland", 11:58:35 INFO - "revision": "3a98a8d388330fbf63bd5123bf02e0e37b6add98", 11:58:35 INFO - "stage_platform": "linux64", 11:58:35 INFO - "builduid": "a0ef3218d1fe4f56956b74c54b51f6f6", 11:58:35 INFO - "slavebuilddir": "test" 11:58:35 INFO - } 11:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:58:35 INFO - Running post-action listener: _resource_record_post_action 11:58:35 INFO - [mozharness: 2016-07-19 18:58:35.997656Z] Finished read-buildbot-config step (success) 11:58:35 INFO - [mozharness: 2016-07-19 18:58:35.997745Z] Running download-and-extract step. 11:58:35 INFO - Running pre-action listener: _resource_record_pre_action 11:58:35 INFO - Running main action method: download_and_extract 11:58:35 INFO - mkdir: /builds/slave/test/build/tests 11:58: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')]} 11:58:35 INFO - https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:36 INFO - Downloaded 1361 bytes. 11:58:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:58:36 INFO - Using the following test package requirements: 11:58:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:58:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:58:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'jsshell-linux-x86_64.zip'], 11:58:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:58:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:58:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:58:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:58:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:58:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:58:36 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')]} 11:58:36 INFO - https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:37 INFO - Downloaded 22765221 bytes. 11:58:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:58:38 INFO - Return code: 0 11:58:38 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 11:58: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')]} 11:58:38 INFO - https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:39 INFO - Downloaded 22765221 bytes. 11:58:39 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'] 11:58:39 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 11:58:41 INFO - Return code: 0 11:58: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')]} 11:58:41 INFO - https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:42 INFO - Downloaded 14403317 bytes. 11:58:42 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'] 11:58:42 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 11:58:42 INFO - Return code: 0 11:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:58:42 INFO - https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XR7XGWsYQcuJRQEy80TkIg/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 11:58:44 INFO - Downloaded 57136338 bytes. 11:58:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:58:44 INFO - mkdir: /builds/slave/test/properties 11:58:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:44 INFO - Contents: 11:58:44 INFO - build_url:https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:58:44 INFO - Running post-action listener: _resource_record_post_action 11:58:44 INFO - Running post-action listener: set_extra_try_arguments 11:58:44 INFO - [mozharness: 2016-07-19 18:58:44.770114Z] Finished download-and-extract step (success) 11:58:44 INFO - [mozharness: 2016-07-19 18:58:44.770343Z] Running populate-webroot step. 11:58:44 INFO - Running pre-action listener: _resource_record_pre_action 11:58:44 INFO - Running main action method: populate_webroot 11:58:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:44 INFO - '--tppagecycles', 11:58:44 INFO - '7'], 11:58:44 INFO - 'tests': ['tsvgm']}}, 11:58:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:58:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:58:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['damp', 'tps']}, 11:58:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'tests': ['damp', 'tps']}, 11:58:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['dromaeo_dom']}, 11:58:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['basic_compositor_video']}, 11:58:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:58:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['a11yr', 11:58:44 INFO - 'ts_paint', 11:58:44 INFO - 'tpaint', 11:58:44 INFO - 'sessionrestore', 11:58:44 INFO - 'sessionrestore_no_auto_restore', 11:58:44 INFO - 'tabpaint']}, 11:58:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['tsvgx', 11:58:44 INFO - 'tsvgr_opacity', 11:58:44 INFO - 'tart', 11:58:44 INFO - 'tscrollx', 11:58:44 INFO - 'cart']}, 11:58:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:44 INFO - 'tsvgr_opacity', 11:58:44 INFO - 'tart', 11:58:44 INFO - 'tscrollx', 11:58:44 INFO - 'cart']}, 11:58:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'talos_options': ['--disable-e10s'], 11:58:44 INFO - 'tests': ['tp5o']}, 11:58:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'tests': ['tp5o']}, 11:58:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'talos_options': ['--disable-e10s', 11:58:44 INFO - '--xperf_path', 11:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:44 INFO - 'tests': ['tp5n']}, 11:58:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:44 INFO - 'talos_options': ['--xperf_path', 11:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:44 INFO - 'tests': ['tp5n']}}, 11:58:44 INFO - 'talos.zip': {'path': '', 11:58:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:44 INFO - Running post-action listener: _resource_record_post_action 11:58:44 INFO - [mozharness: 2016-07-19 18:58:44.787801Z] Finished populate-webroot step (success) 11:58:44 INFO - [mozharness: 2016-07-19 18:58:44.787889Z] Running create-virtualenv step. 11:58:44 INFO - Running pre-action listener: _resource_record_pre_action 11:58:44 INFO - Running main action method: create_virtualenv 11:58:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:44 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 11:58:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:44 INFO - Using real prefix '/usr' 11:58:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:47 INFO - Installing pip.................done. 11:58:47 INFO - Return code: 0 11:58:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:47 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:58:47 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 11:58:47 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 11:58:47 INFO - Using env: {'DISPLAY': ':0', 11:58:47 INFO - 'HOME': '/home/cltbld', 11:58:47 INFO - 'LANG': 'en_US.UTF-8', 11:58:47 INFO - 'LANGUAGE': 'en_US:en', 11:58:47 INFO - 'LOGNAME': 'cltbld', 11:58:47 INFO - 'MAIL': '/var/mail/cltbld', 11:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:47 INFO - 'MOZ_NO_REMOTE': '1', 11:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:47 INFO - 'NO_EM_RESTART': '1', 11:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:47 INFO - 'PWD': '/builds/slave/test', 11:58:47 INFO - 'SHELL': '/bin/bash', 11:58:47 INFO - 'SHLVL': '1', 11:58:47 INFO - 'TERM': 'linux', 11:58:47 INFO - 'TMOUT': '86400', 11:58:47 INFO - 'USER': 'cltbld', 11:58:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:47 INFO - '_': '/tools/buildbot/bin/python'} 11:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:47 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 11:58:47 INFO - Cleaning up... 11:58:47 INFO - Return code: 0 11:58:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:47 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:58:47 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 11:58:47 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 11:58:47 INFO - Using env: {'DISPLAY': ':0', 11:58:47 INFO - 'HOME': '/home/cltbld', 11:58:47 INFO - 'LANG': 'en_US.UTF-8', 11:58:47 INFO - 'LANGUAGE': 'en_US:en', 11:58:47 INFO - 'LOGNAME': 'cltbld', 11:58:47 INFO - 'MAIL': '/var/mail/cltbld', 11:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:47 INFO - 'MOZ_NO_REMOTE': '1', 11:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:47 INFO - 'NO_EM_RESTART': '1', 11:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:47 INFO - 'PWD': '/builds/slave/test', 11:58:47 INFO - 'SHELL': '/bin/bash', 11:58:47 INFO - 'SHLVL': '1', 11:58:47 INFO - 'TERM': 'linux', 11:58:47 INFO - 'TMOUT': '86400', 11:58:47 INFO - 'USER': 'cltbld', 11:58:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:47 INFO - '_': '/tools/buildbot/bin/python'} 11:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:47 INFO - Downloading/unpacking psutil>=3.1.1 11:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:49 INFO - Installing collected packages: psutil 11:58:49 INFO - Running setup.py install for psutil 11:58:50 INFO - building 'psutil._psutil_linux' extension 11:58:50 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 11:58:50 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 11:58:50 INFO - building 'psutil._psutil_posix' extension 11:58:50 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 11:58:50 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 11:58:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:50 INFO - Successfully installed psutil 11:58:50 INFO - Cleaning up... 11:58:50 INFO - Return code: 0 11:58:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:50 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:58:50 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 11:58:50 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 11:58:50 INFO - Using env: {'DISPLAY': ':0', 11:58:50 INFO - 'HOME': '/home/cltbld', 11:58:50 INFO - 'LANG': 'en_US.UTF-8', 11:58:50 INFO - 'LANGUAGE': 'en_US:en', 11:58:50 INFO - 'LOGNAME': 'cltbld', 11:58:50 INFO - 'MAIL': '/var/mail/cltbld', 11:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:50 INFO - 'MOZ_NO_REMOTE': '1', 11:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:50 INFO - 'NO_EM_RESTART': '1', 11:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:50 INFO - 'PWD': '/builds/slave/test', 11:58:50 INFO - 'SHELL': '/bin/bash', 11:58:50 INFO - 'SHLVL': '1', 11:58:50 INFO - 'TERM': 'linux', 11:58:50 INFO - 'TMOUT': '86400', 11:58:50 INFO - 'USER': 'cltbld', 11:58:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:50 INFO - '_': '/tools/buildbot/bin/python'} 11:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:50 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 11:58:50 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 11:58:50 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 11:58:50 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 11:58:50 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 11:58:50 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 11:58:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:52 INFO - Installing collected packages: mozsystemmonitor 11:58:52 INFO - Running setup.py install for mozsystemmonitor 11:58:52 INFO - Successfully installed mozsystemmonitor 11:58:52 INFO - Cleaning up... 11:58:52 INFO - Return code: 0 11:58:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:52 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')]} 11:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:52 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')]} 11:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:52 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:58:52 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 11:58:52 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 11:58:52 INFO - Using env: {'DISPLAY': ':0', 11:58:52 INFO - 'HOME': '/home/cltbld', 11:58:52 INFO - 'LANG': 'en_US.UTF-8', 11:58:52 INFO - 'LANGUAGE': 'en_US:en', 11:58:52 INFO - 'LOGNAME': 'cltbld', 11:58:52 INFO - 'MAIL': '/var/mail/cltbld', 11:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:52 INFO - 'MOZ_NO_REMOTE': '1', 11:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:52 INFO - 'NO_EM_RESTART': '1', 11:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:52 INFO - 'PWD': '/builds/slave/test', 11:58:52 INFO - 'SHELL': '/bin/bash', 11:58:52 INFO - 'SHLVL': '1', 11:58:52 INFO - 'TERM': 'linux', 11:58:52 INFO - 'TMOUT': '86400', 11:58:52 INFO - 'USER': 'cltbld', 11:58:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:52 INFO - '_': '/tools/buildbot/bin/python'} 11:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:55 INFO - warning: no files found matching '*.txt' 11:58:55 INFO - no previously-included directories found matching 'build' 11:58:55 INFO - no previously-included directories found matching 'dist' 11:58:55 INFO - no previously-included directories found matching '.git*' 11:58:55 INFO - Installing collected packages: jsonschema, functools32 11:58:55 INFO - Running setup.py install for functools32 11:58:55 INFO - warning: no files found matching '*.txt' 11:58:55 INFO - no previously-included directories found matching 'build' 11:58:55 INFO - no previously-included directories found matching 'dist' 11:58:55 INFO - no previously-included directories found matching '.git*' 11:58:55 INFO - Successfully installed jsonschema functools32 11:58:55 INFO - Cleaning up... 11:58:55 INFO - Return code: 0 11:58:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:55 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:58:55 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 11:58:55 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 11:58:55 INFO - Using env: {'DISPLAY': ':0', 11:58:55 INFO - 'HOME': '/home/cltbld', 11:58:55 INFO - 'LANG': 'en_US.UTF-8', 11:58:55 INFO - 'LANGUAGE': 'en_US:en', 11:58:55 INFO - 'LOGNAME': 'cltbld', 11:58:55 INFO - 'MAIL': '/var/mail/cltbld', 11:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:55 INFO - 'MOZ_NO_REMOTE': '1', 11:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:55 INFO - 'NO_EM_RESTART': '1', 11:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:55 INFO - 'PWD': '/builds/slave/test', 11:58:55 INFO - 'SHELL': '/bin/bash', 11:58:55 INFO - 'SHLVL': '1', 11:58:55 INFO - 'TERM': 'linux', 11:58:55 INFO - 'TMOUT': '86400', 11:58:55 INFO - 'USER': 'cltbld', 11:58:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:55 INFO - '_': '/tools/buildbot/bin/python'} 11:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:55 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 11:58:55 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 11:58:55 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 11:58:55 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 11:58:55 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 11:58:55 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 11:59:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:11 INFO - Downloading docopt-0.6.1.tar.gz 11:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:11 INFO - Running setup.py install for blobuploader 11:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:11 INFO - Running setup.py install for requests 11:59:11 INFO - Running setup.py install for docopt 11:59:11 INFO - Successfully installed blobuploader requests docopt 11:59:11 INFO - Cleaning up... 11:59:12 INFO - Return code: 0 11:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:59:12 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 11:59:12 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 11:59:12 INFO - Using env: {'DISPLAY': ':0', 11:59:12 INFO - 'HOME': '/home/cltbld', 11:59:12 INFO - 'LANG': 'en_US.UTF-8', 11:59:12 INFO - 'LANGUAGE': 'en_US:en', 11:59:12 INFO - 'LOGNAME': 'cltbld', 11:59:12 INFO - 'MAIL': '/var/mail/cltbld', 11:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:12 INFO - 'MOZ_NO_REMOTE': '1', 11:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:12 INFO - 'NO_EM_RESTART': '1', 11:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:12 INFO - 'PWD': '/builds/slave/test', 11:59:12 INFO - 'SHELL': '/bin/bash', 11:59:12 INFO - 'SHLVL': '1', 11:59:12 INFO - 'TERM': 'linux', 11:59:12 INFO - 'TMOUT': '86400', 11:59:12 INFO - 'USER': 'cltbld', 11:59:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:12 INFO - '_': '/tools/buildbot/bin/python'} 11:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:12 INFO - Running setup.py (path:/tmp/pip-uCY7Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:12 INFO - Running setup.py (path:/tmp/pip-jcnepH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:12 INFO - Running setup.py (path:/tmp/pip-jHbFhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:13 INFO - Running setup.py (path:/tmp/pip-P5Y_yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:13 INFO - Running setup.py (path:/tmp/pip-dtj7h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:13 INFO - Running setup.py (path:/tmp/pip-P0a2zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:13 INFO - Running setup.py (path:/tmp/pip-PKEsmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:13 INFO - Running setup.py (path:/tmp/pip-9j3g2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:13 INFO - Running setup.py (path:/tmp/pip-7s9X4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:13 INFO - Running setup.py (path:/tmp/pip-o2EFy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:13 INFO - Running setup.py (path:/tmp/pip-xhF59B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:13 INFO - Running setup.py (path:/tmp/pip-LnQKPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:13 INFO - Running setup.py (path:/tmp/pip-juksPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:13 INFO - Running setup.py (path:/tmp/pip-CSFtFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:13 INFO - Running setup.py (path:/tmp/pip-1vEtLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:13 INFO - Running setup.py (path:/tmp/pip-Hhw9n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:13 INFO - Running setup.py (path:/tmp/pip-dnlPC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:14 INFO - Running setup.py install for manifestparser 11:59:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozcrash 11:59:14 INFO - Running setup.py install for mozdebug 11:59:14 INFO - Running setup.py install for mozdevice 11:59:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozfile 11:59:14 INFO - Running setup.py install for mozhttpd 11:59:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozinfo 11:59:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozInstall 11:59:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozleak 11:59:14 INFO - Running setup.py install for mozlog 11:59:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Running setup.py install for moznetwork 11:59:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Running setup.py install for mozprocess 11:59:15 INFO - Running setup.py install for mozprofile 11:59:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Running setup.py install for mozrunner 11:59:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Running setup.py install for mozscreenshot 11:59:15 INFO - Running setup.py install for moztest 11:59:15 INFO - Running setup.py install for mozversion 11:59:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:15 INFO - Cleaning up... 11:59:15 INFO - Return code: 0 11:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:15 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:59:15 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 11:59:15 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 11:59:15 INFO - Using env: {'DISPLAY': ':0', 11:59:15 INFO - 'HOME': '/home/cltbld', 11:59:15 INFO - 'LANG': 'en_US.UTF-8', 11:59:15 INFO - 'LANGUAGE': 'en_US:en', 11:59:15 INFO - 'LOGNAME': 'cltbld', 11:59:15 INFO - 'MAIL': '/var/mail/cltbld', 11:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:15 INFO - 'MOZ_NO_REMOTE': '1', 11:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:15 INFO - 'NO_EM_RESTART': '1', 11:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:15 INFO - 'PWD': '/builds/slave/test', 11:59:15 INFO - 'SHELL': '/bin/bash', 11:59:15 INFO - 'SHLVL': '1', 11:59:15 INFO - 'TERM': 'linux', 11:59:15 INFO - 'TMOUT': '86400', 11:59:15 INFO - 'USER': 'cltbld', 11:59:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:15 INFO - '_': '/tools/buildbot/bin/python'} 11:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:16 INFO - Running setup.py (path:/tmp/pip-yJdohO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:16 INFO - Running setup.py (path:/tmp/pip-QaB90m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:16 INFO - Running setup.py (path:/tmp/pip-JZNWeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:16 INFO - Running setup.py (path:/tmp/pip-D29q5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:16 INFO - Running setup.py (path:/tmp/pip-bsxnA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:16 INFO - Running setup.py (path:/tmp/pip-xdroWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:16 INFO - Running setup.py (path:/tmp/pip-Sfpy6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:16 INFO - Running setup.py (path:/tmp/pip-f_UOw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:16 INFO - Running setup.py (path:/tmp/pip-bnGijY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:16 INFO - Running setup.py (path:/tmp/pip-EDlmwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:16 INFO - Running setup.py (path:/tmp/pip-JHHCNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:16 INFO - Running setup.py (path:/tmp/pip-P87pmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:17 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)) 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:17 INFO - Running setup.py (path:/tmp/pip-n4XNBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:17 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)) 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:17 INFO - Running setup.py (path:/tmp/pip-8zDbQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:17 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)) 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:17 INFO - Running setup.py (path:/tmp/pip-EuMBJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:17 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)) 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:17 INFO - Running setup.py (path:/tmp/pip-7y4CcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:17 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)) 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:17 INFO - Running setup.py (path:/tmp/pip-Fkdx5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:17 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)) 11:59:17 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)) 11:59:17 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)) 11:59:17 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)) 11:59:17 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)) 11:59:17 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)) 11:59:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:20 INFO - Downloading blessings-1.6.tar.gz 11:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:20 INFO - Installing collected packages: blessings 11:59:20 INFO - Running setup.py install for blessings 11:59:20 INFO - Successfully installed blessings 11:59:20 INFO - Cleaning up... 11:59:20 INFO - Return code: 0 11:59:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:20 INFO - Reading from file tmpfile_stdout 11:59:20 INFO - Current package versions: 11:59:20 INFO - argparse == 1.2.1 11:59:20 INFO - blessings == 1.6 11:59:20 INFO - blobuploader == 1.2.4 11:59:20 INFO - docopt == 0.6.1 11:59:20 INFO - functools32 == 3.2.3-2 11:59:20 INFO - jsonschema == 2.5.1 11:59:20 INFO - manifestparser == 1.1 11:59:20 INFO - mozInstall == 1.12 11:59:20 INFO - mozcrash == 0.17 11:59:20 INFO - mozdebug == 0.1 11:59:20 INFO - mozdevice == 0.48 11:59:20 INFO - mozfile == 1.2 11:59:20 INFO - mozhttpd == 0.7 11:59:20 INFO - mozinfo == 0.9 11:59:20 INFO - mozleak == 0.1 11:59:20 INFO - mozlog == 3.3 11:59:20 INFO - moznetwork == 0.27 11:59:20 INFO - mozprocess == 0.23 11:59:20 INFO - mozprofile == 0.28 11:59:20 INFO - mozrunner == 6.12 11:59:20 INFO - mozscreenshot == 0.1 11:59:20 INFO - mozsystemmonitor == 0.3 11:59:20 INFO - moztest == 0.7 11:59:20 INFO - mozversion == 1.4 11:59:20 INFO - psutil == 3.1.1 11:59:20 INFO - requests == 1.2.3 11:59:21 INFO - wsgiref == 0.1.2 11:59:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:21 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')]} 11:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:21 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')]} 11:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:21 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:59:21 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 11:59:21 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 11:59:21 INFO - Using env: {'DISPLAY': ':0', 11:59:21 INFO - 'HOME': '/home/cltbld', 11:59:21 INFO - 'LANG': 'en_US.UTF-8', 11:59:21 INFO - 'LANGUAGE': 'en_US:en', 11:59:21 INFO - 'LOGNAME': 'cltbld', 11:59:21 INFO - 'MAIL': '/var/mail/cltbld', 11:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:21 INFO - 'MOZ_NO_REMOTE': '1', 11:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:21 INFO - 'NO_EM_RESTART': '1', 11:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:21 INFO - 'PWD': '/builds/slave/test', 11:59:21 INFO - 'SHELL': '/bin/bash', 11:59:21 INFO - 'SHLVL': '1', 11:59:21 INFO - 'TERM': 'linux', 11:59:21 INFO - 'TMOUT': '86400', 11:59:21 INFO - 'USER': 'cltbld', 11:59:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:21 INFO - '_': '/tools/buildbot/bin/python'} 11:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 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)) 11:59:21 INFO - Cleaning up... 11:59:21 INFO - Return code: 0 11:59:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:21 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')]} 11:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:21 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')]} 11:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:21 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 0x1790030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a51180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, '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-1468954713.194361-1095684040', '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 11:59:21 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 11:59:21 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 11:59:21 INFO - Using env: {'DISPLAY': ':0', 11:59:21 INFO - 'HOME': '/home/cltbld', 11:59:21 INFO - 'LANG': 'en_US.UTF-8', 11:59:21 INFO - 'LANGUAGE': 'en_US:en', 11:59:21 INFO - 'LOGNAME': 'cltbld', 11:59:21 INFO - 'MAIL': '/var/mail/cltbld', 11:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:21 INFO - 'MOZ_NO_REMOTE': '1', 11:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:21 INFO - 'NO_EM_RESTART': '1', 11:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:21 INFO - 'PWD': '/builds/slave/test', 11:59:21 INFO - 'SHELL': '/bin/bash', 11:59:21 INFO - 'SHLVL': '1', 11:59:21 INFO - 'TERM': 'linux', 11:59:21 INFO - 'TMOUT': '86400', 11:59:21 INFO - 'USER': 'cltbld', 11:59:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:21 INFO - '_': '/tools/buildbot/bin/python'} 11:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:21 INFO - Cleaning up... 11:59:21 INFO - Return code: 0 11:59:21 INFO - Running post-action listener: _resource_record_post_action 11:59:21 INFO - Running post-action listener: _start_resource_monitoring 11:59:21 INFO - Starting resource monitoring. 11:59:21 INFO - [mozharness: 2016-07-19 18:59:21.478021Z] Finished create-virtualenv step (success) 11:59:21 INFO - [mozharness: 2016-07-19 18:59:21.478506Z] Running install step. 11:59:21 INFO - Running pre-action listener: _resource_record_pre_action 11:59:21 INFO - Running main action method: install 11:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:21 INFO - Reading from file tmpfile_stdout 11:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:21 INFO - Reading from file tmpfile_stdout 11:59:21 INFO - Output received: 11:59:21 INFO - Usage: mozinstall [options] installer 11:59:21 INFO - Options: 11:59:21 INFO - -h, --help show this help message and exit 11:59:21 INFO - -d DEST, --destination=DEST 11:59:21 INFO - Directory to install application into. [default: 11:59:21 INFO - "/builds/slave/test"] 11:59:21 INFO - --app=APP Application being installed. [default: firefox] 11:59:21 INFO - mkdir: /builds/slave/test/build/application 11:59:21 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'] 11:59:21 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 11:59:38 INFO - Reading from file tmpfile_stdout 11:59:38 INFO - Output received: 11:59:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:59:38 INFO - Running post-action listener: _resource_record_post_action 11:59:38 INFO - [mozharness: 2016-07-19 18:59:38.118559Z] Finished install step (success) 11:59:38 INFO - [mozharness: 2016-07-19 18:59:38.118830Z] Running run-tests step. 11:59:38 INFO - Running pre-action listener: _resource_record_pre_action 11:59:38 INFO - Running main action method: run_tests 11:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:38 INFO - Python 2.7.3 11:59:38 INFO - Return code: 0 11:59:38 INFO - grabbing minidump binary from tooltool 11:59: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')]} 11:59:38 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 0x1a4f3b0>, '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 0x1a502b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:38 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 11:59:38 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 11:59:38 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 11:59:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:38 INFO - Return code: 0 11:59:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:59:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:59:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:38 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/XR7XGWsYQcuJRQEy80TkIg/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 11:59:38 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/XR7XGWsYQcuJRQEy80TkIg/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 11:59:38 INFO - Using env: {'DISPLAY': ':0', 11:59:38 INFO - 'HOME': '/home/cltbld', 11:59:38 INFO - 'LANG': 'en_US.UTF-8', 11:59:38 INFO - 'LANGUAGE': 'en_US:en', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MAIL': '/var/mail/cltbld', 11:59:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SHLVL': '1', 11:59:38 INFO - 'TERM': 'linux', 11:59:38 INFO - 'TMOUT': '86400', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1468954713.194361-1095684040', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - '_': '/tools/buildbot/bin/python'} 11:59:38 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/XR7XGWsYQcuJRQEy80TkIg/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 11:59:38 INFO - mozversion application_buildid: 20160719102519 11:59:38 INFO - mozversion application_changeset: 3a98a8d388330fbf63bd5123bf02e0e37b6add98 11:59:38 INFO - mozversion application_display_name: Nightly 11:59:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:38 INFO - mozversion application_name: Firefox 11:59:38 INFO - mozversion application_remotingname: firefox 11:59:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:59:38 INFO - mozversion application_vendor: Mozilla 11:59:38 INFO - mozversion application_version: 50.0a1 11:59:38 INFO - mozversion platform_buildid: 20160719102519 11:59:38 INFO - mozversion platform_changeset: 3a98a8d388330fbf63bd5123bf02e0e37b6add98 11:59:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:59:38 INFO - mozversion platform_version: 50.0a1 11:59:38 INFO - using testdate: 1468954778 11:59:38 INFO - actual date: 1468954778 11:59:38 INFO - starting webserver on 'localhost:49070' 11:59:38 INFO - SUITE-START | Running 2 tests 11:59:38 INFO - TEST-START | dromaeo_css 11:59:38 INFO - operating with platform_type : linux_ 11:59:38 INFO - Initialising browser for dromaeo_css test... 11:59:38 INFO - TEST-INFO | started process 29929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJfPuZ/profile http://localhost:49070/getInfo.html) 11:59:42 INFO - PROCESS | 29929 | __metrics Screen width/height:1600/1200 11:59:42 INFO - PROCESS | 29929 | colorDepth:24 11:59:42 INFO - PROCESS | 29929 | Browser inner width/height: 1024/697 11:59:42 INFO - PROCESS | 29929 | __metrics 11:59:43 INFO - PROCESS | 29929 | 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" 11:59:43 INFO - PROCESS | 29929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:59:44 INFO - TEST-INFO | 29929: exit 0 11:59:44 INFO - Browser initialized. 11:59:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:44 INFO - TEST-INFO | started process 30009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJfPuZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:56 INFO - PROCESS | 30009 | RSS: Main: 159477760 11:59:56 INFO - PROCESS | 30009 | 12:00:47 INFO - PROCESS | 30009 | 1468954847001 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] 12:02:59 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49070/tests/dromaeo/cssquery-ext.html) 12:03:00 INFO - PROCESS | 30009 | RSS: Main: 270426112 12:03:00 INFO - PROCESS | 30009 | 12:06:03 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-ext.html (next: http://localhost:49070/tests/dromaeo/cssquery-jquery.html) 12:06:04 INFO - PROCESS | 30009 | RSS: Main: 245567488 12:06:04 INFO - PROCESS | 30009 | 12:09:06 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49070/tests/dromaeo/cssquery-mootools.html) 12:09:07 INFO - PROCESS | 30009 | RSS: Main: 240427008 12:09:07 INFO - PROCESS | 30009 | 12:12:09 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49070/tests/dromaeo/cssquery-prototype.html) 12:12:10 INFO - PROCESS | 30009 | RSS: Main: 238399488 12:12:10 INFO - PROCESS | 30009 | 12:15:13 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49070/tests/dromaeo/cssquery-yui.html) 12:15:13 INFO - PROCESS | 30009 | RSS: Main: 225910784 12:15:13 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | Cycle 1(1): loaded http://localhost:49070/tests/dromaeo/cssquery-yui.html (next: http://localhost:49070/tests/dromaeo/cssquery-dojo.html) 12:18:16 INFO - PROCESS | 30009 | RSS: Main: 265990144 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | __start_tp_report 12:18:16 INFO - PROCESS | 30009 | _x_x_mozilla_page_load 12:18:16 INFO - PROCESS | 30009 | _x_x_mozilla_page_load_details 12:18:16 INFO - PROCESS | 30009 | |i|pagename|runs| 12:18:16 INFO - PROCESS | 30009 | |0;dojo.html;2546.2488565873064;2557.8721063946796;2590.9481810363786;2596.4028273497097;2597.103999120304;4570.542945705428;4615;4667.463241727202;4683.5550622690835;4698.248280275152;4675.789589468473;4683.391159149314;4765.90468190636;4766.73782941938;4793.496682848303;4121.835126594932;4230.069384735353;4339.435873336462;4367.213901497729;4500.302453119772;4404.8017839197155;4444.133393988173;4455.1089782043555;4467.798949047285;4488.102379524092;4226.830926762926;4261.147770445892;4288.4210631564965;4292.678049146295;4301.225779359714;4203.7687927164;4210.389493523422;4219.261629214875;4255.531891491964;4271.8718438446895;4266.338717498762;4271.231178387889;4282.914341713148;4311.547287534827;4329.350597410382;4547.272436410191;4673.509281525425;4689.929651055237;4705.929411058837;4718.032803275355;5015.172496538067;5073.898522029539;5079.873003174913;5080.720560369178;5081.034603425337;5061.316722242487;5114.309568208281;5126.897462050738;5127.820526281562;5128.769205385766;4548.431446069274;4681.6722829401615;4752.263399173134;4752.833650822205;4756.881077973078;5188.481151884856;5212.947870521246;5219.034478621391;5220.086484865134;5226.085435048852;4991.3511243538105;4992.775325110306;4994.200927851526;4995;5002.59979201663;4808.206645903457;5022;5052.646314757932;5056.115179843586;5077.314562534085;5046.722430266297;5050.9494905051215;5052.469490703496;5078.873028174326;5096.362954630671;5019.52314530119;5024.145895197825;5027.321311622884;5031.270465782514;5076.340075790197;4157.064660451374;4199.076203235283;4255.659547236276;4327.870163895088;4372.7376357418025;3726.459663348799;3751.118487155516;3755.5681096673684;3783.621637836194;3807.2385522895534;4345.391645169679;4374;4378.343248512685;4412.514623391425;4421.115776844644;4894.388201474816;4948.035133149001;4992.475790041994;5101.234814777738;5118.744062796845;4316.115196384733;4346.695731298842;4351.956480435155;4361.433013708261;4394.604485596312;4529.773511324421;4549.567791059844;4550.180967425829;4559;4583.220852455091;4521.525239849769;4714.198586240416;4717.575418212377;4738.218193997952;4760.523947605212;5056.650442830856;5074.644774865724;5079.593632509316;5082.618803589819;5117.820876269313;4755.38180036593;4767.427908650984;4767.594754445772;4768.380110585602;4804.95195048045;4803.087413391444;4948.653594248368;4980.352554167935;5004.899902001866;5024.698518088926;5082.33929589151;5100.183970564692;5103.515166059218;5110.1568241239775;5154.922676159786;4878.170710979213;4883.291922671264;4887.560119589254;4890.608751299958;4933.407991041098;4681.204195286878;4689.835855745033;4710.788014539423;4714.834980775657;4772.212584923587;4701.059788042337;4703.082898834831;4718.41019872516;4767.928481072718;4772.570468657837;4739.668223224341;4808.663393562417;4817.638677099161;4820.276958456259;4842.7578621068105;4678.906421871611;4681.695689780154;4729.314249433882;4761.6428767843245;4806.279058141306 12:18:16 INFO - PROCESS | 30009 | |1;ext.html;548.5222193620856;576.8875069361471;581.2414798687712;590.1413443439795;599.0116308091647;27023.594646080324;39433.80283098584;40166.39750403739;40246.19507609846;40286.59713402861;41682.58317416825;41925;41934.58065419345;42172;42205.15589688212;7480.850382992364;7626.580538070404;7627.122880868688;7855.842883142348;8010.279074883259;7601.695932162706;10356.637517686882;10719.83920241197;10721.195910306758;10722.35665860047;10396;10428.270021098526;10430.63492777753;10453.216008799332;10457;7645.891345754834;7884.32983196429;10308.32995855267;10380.11768999636;10387.532561034734;7624.390048796083;9828.459434731158;10172.44051577163;10178.236632252536;10563.63027294041;38709;39188.60811391878;39203.215935681415;39218.21563568713;39230.21539569221;3033.2871775132826;3106.301082256497;3130.546070819741;3147.921301967446;3552.0231936217747;29834.10497685073;30063.549046764096;30066.24834379136;30463.847680761675;30566.235844104074;3377.628460869302;3394.4568868980846;3414.5219669246326;3419.3161367726307;3442.4492081267126;265373;270104;270449;271361.999999998;271890;56499.71750141223;56888.43111568914;56979.43020569824;56991.430085699445;57066.85866282651;58535;58645.413545863994;58854.7057264711;59054.11418828721;59064.70467647634;14686.412543498354;15082.396704131712;15127.773083403757;15128.924355378153;15136.697266054618;10070.345427547332;10163.186945044527;10221.488925553693;11186.16103792219;11360.886391136148;18173.90913045453;18446.169922353525;18470.538236543925;18470.538236543925;18511.53721156982;6863.347981941708;6886.51794374389;6998.62046904055;7055;7059.82350441243;781.9491733037335;875.2691502595277;926.333040211047;960.6109525642127;1003.693873368615;27345.316367090585;27680.307992300353;28579;28585.428291434055;28758.85620571884;991.7223177510309;1000.6097621927454;1015.9339642923186;1036.8185567525652;1046.4663021858755;14757.40970361195;15217.467388641344;15227.771583426258;15256.389744410099;15380.38478460849;414368;418144;418391;418564;418743;49109.50890491121;50157.74921125371;50166.49833501691;50177;50323;1055.37205362809;1151.4875880233383;1161.703765539799;1186.1281957761212;1200.855897292313;27969.300767480974;29030.27424314409;29129.56305655459;29894.85052574723;29939.401211976074;41383;41734.58265417307;41854.58145418507;41929.79035104805;42024.36963445612;311560;312272;313247;313329;313879;23350.883245583664;24048.51902961966;24490.14284500034;25071;25311.240662780147;42051.57948420477;42086;42146;43049;43393;35594.64405355913;35721.82139089288;36174;36301;36646.633533664324;36612.81693591515;36756.44865327076;36789.81605091957;37086.44370334393;37103.257934840614;34692.30615387628;35305.47041794426;35827.92516224518;35912.640873591976;35933.1016724584;30576.541351879296;32555.511667324536;32733.67266327306;32752.181195470304;32947.50578741273;24640;25255.74744252534;25341.57788869909;25564.744352556238;25588 12:18:16 INFO - PROCESS | 30009 | |2;jquery.html;346.6377635371037;372.7781969728011;378.9905252368691;381.2774791769595;391.8491380818384;13180.934095329521;16758.83241167588;17168.3132674693;18412.81587184131;18413.815861841376;16996.235169417374;17017.74473382897;18081.90959045203;18083.728744068816;18131.365402210926;4902.950970490294;5218.921716174261;5224.085784987631;5231.267622532849;5240.266362709223;3807.923841523168;3979.403089536578;3983.4024896265646;4032.354823228284;5058.772355244005;5746.626469279504;6039.5772295939305;6050.515958723292;6146.508279337642;6155.446009859112;6051.281538945698;6053.636781793107;6168;6193.318734939153;6194.659293738842;5236.659617124913;5387.272718183034;5387.4073851876265;5393.1370980642905;5412.99859525989;18185.090745462672;18249.17878695462;18258.36095736656;18919.95940223287;21896;1918.5491409518752;1937.4865660599953;1945.046927005771;1958.5299528113292;1961.4507937777446;13140.60578182656;13349.466021359134;13665.18008919468;13850.861491385158;14265.57203283903;1690.6365131496786;1699.6855581717423;1763.3299346248343;1834.871558990871;1844.8431883289936;70527.29472705259;71177.64411177962;71665.64167179183;72134.27865721328;72505.27494725038;8470.280026197843;9238.168564829197;9520.428774273565;9584.808303833885;10144.898551014396;11989.760204795855;12768.361581920866;12783.16909400886;13107.082504224803;13149.671258218621;7051.753188638373;7093.077899872984;7302.890456643155;7326.523775954546;7334.193238743734;6805.6597170141295;6817.113775209191;6876.69054892531;6936.895946560806;6961.512694111364;6281.905771413432;6331.873362532723;6384.744610215539;6413.486921046305;6438.195225596801;1695.9576010599833;1777.173614269371;1789.3021721528614;1789.731540268944;1842.4519625145933;771.1034928205848;903.8623655055745;909.6225066597289;914.6752902719572;925.3476299209042;17584.208710608054;17846.375376861746;18380.356687515872;18483;18885.150168242188;883.3816328570026;885.203317014692;889;925.4123631493915;932.9720108396759;9600.903990960142;9752.073553012453;10373.222008349405;10491.632792852366;10561.524731387106;384380;384656;388731;399295;399957;68579.3142068583;70568;71416;72253.27746722571;72880;893.5130353957109;934.2806039349798;957.5355952363099;960.4045491795132;962.4898803634085;16515.66968660644;16595.50213493597;16762.245698943334;16949.559167516265;17071.91464042672;23906.52186956286;36832;37948;38262.42606360962;40172.598274016884;48487;50096;50263.74868125636;50311;50397.74801125971;7341.669624866787;7482.588457634664;7649.120351159688;7682.884756728766;7899.289063984269;10373.792524149625;11922.344271065174;12209.206401583868;12342.259464432163;12505.249685018927;10594.31136976094;10683.679489615324;10702.464876755976;10878.12974962017;10912.890871091187;10448.164146868385;10996.945015274872;11016.724581885517;11260.662180134608;11497.482613282255;10190.592376305161;10209.540570674486;10727.946360268148;10986.285891417032;11413.486393112164;7544;7600.695972161052;7733.806654833449;7792.805179870548;7913.44605877583;9810.950945245228;10564.524596393334;10626.52180651857;10674.73313167177;10835.079018283534 12:18:16 INFO - PROCESS | 30009 | |3;mootools.html;1276.8403949506312;1386.2237147197568;1396.9161850288976;1679.3114822922605;1711.4266720648582;7484.139323977744;7833.686652533892;8009.519428834266;8016.078151012635;8020.639071241793;6533.118029066075;7499.100107987049;7656.042994625672;7672.96163519183;7839.294463498299;2205.4155648753135;2228.0308065991267;2233.0621139121527;2233.486298151426;2239.507308392151;2199.9010044547954;2243.7756224377595;2271.5116250006245;2271.806896413807;2273.2611901132113;1846.5199048247484;1913.0434782608695;1913.6746753052014;1914.7606549181353;2149.8387620928415;2167.4689701023194;2192.758796532396;2195.319450970196;2196.121551379445;2197.7582465928735;2162.935111946644;2201.3836125884777;2211.380813372258;2249.977500224993;2255.481239314967;6561.442277406426;7414.443916706215;7590.430717696195;7877.212278772135;7940.2059794020715;4610.331501932201;4760.33355330254;4766.713997160182;4767.570918617306;4768.451628062782;2815.0850973433717;2877.84171870547;2900.3039270575123;2931.6482022157265;2945.882164713409;922.0871337376017;922.3082687984012;940.1632547033146;944.8677185194078;952.4475804033644;10261.589536418534;10325.225608079425;10331.690049298533;10334.534945927377;10335.276530642783;4137.54487006429;4236.894077648022;4367.934480982788;4377.562243775661;4408.713433626868;8733.868991965126;8776.297896168291;8801.779955501164;8805;8805.823883522422;4604.7927843247135;4604.930926036112;4606.677532572688;4607.170709272363;4607.585317321457;4148.066684995852;4192.622663960197;4209.1792100540715;4209.5790420957655;4301.548337424525;3616.7829930203748;3667.94498082529;3702.278055779151;3720.8697695580527;3737.71967102463;1195.9342236177094;1224.6081253998634;1224.9020078393708;1232.4577186038114;1247.7566874459574;724.7282269149069;738.903942487484;853.4452605806151;857.3784006595168;864.9610767515477;5090.643654944192;5215.452377500384;5250.448702886219;5271.815486457956;5299.655522391032;407.06172272911226;413.50173041484936;414.6164797562243;421.56999860142486;424.0395504183028;3549.2369140634887;3562.2163124112653;3601.423772196436;3620.0768803954825;3624.7462677612843;9213.355065145375;9603.807923841485;9715.07706767856;9724.805503889882;9744.512774361254;9644.083812037845;9649.276304277208;9649.517524123767;9659.082387173208;9671.9032809671;7182.928170718226;7284.235155308616;7375.11498620169;7375.4099672026105;7384.815379615553;5233.215017747216;5253.212018197301;5267.394249661184;5291.23277124807;5307.177387504943;8872.423292485968;8929.241014513838;9042;9092.454452732858;9158.450492970444;8907.777305567153;9098.135677110664;9125.817483650157;9310.394824336396;9310.48792316402;6792.184937807495;6837.179538455218;6856.588604683735;6860.348266914635;6885.208201056742;7219.711211551689;7496.662650180646;7498.10022797246;7697.499662521918;7706.614669266626;5180.533751962191;6401.64790936503;6671.432928201158;6771.119754431892;6930.896036559355;6550.246721626883;6570.638614876037;6642.43539299165;7017.3684368407085;7028.543144695578;6428.453581445629;6496.220453545605;6499.057636642755;6502.967485162544;6507.642079685663;4557.612602928788;4586.518415566451;4611.608013318905;4691.859244222679;4770.165221086366;4793.856184314476;4800.543948324904;4814.9518504814505;4841.672323603397;4886.53577910098 12:18:16 INFO - PROCESS | 30009 | |4;prototype.html;298.150271725582;301.27092436304144;308.3816947021222;309.91012606344157;311.9610048743907;4790.880227994302;4848.103100926327;4879.194932836078;4879.463259041502;4912.870039890823;4581.977090114553;4665.463471700756;4736.194846876031;4820.228763397857;4858.927116093261;3808.4096964970336;3826.4834247376666;3848.9615103848955;3849.2493963677093;3850.711196660248;3851.2297540491872;3861.6524512793844;3879.70902182336;3882;3891.805409729516;3635.1457407509215;3710.0353907983986;3812.4178465936743;3827.0432391902023;3844.4233364995334;3781.9054523636855;3794.6015668354976;3815.4467602197665;3824.3116239076953;3826.502554667903;3406.1654894550747;3412.5051867479324;3420.9486857697157;3421.863125474978;3434.295969326282;4519.305260527302;4742.359781429497;4772.785224664898;4795.0409918016185;4803.759812009385;4231.365295205713;4302.7203231790145;4303;4303.548127446605;4323.027318853265;5064.746762661852;5072.6195535335;5090.414602320743;5100.668456550312;5105.795768169269;3575.8199794067896;3636.4363523653874;3653.3058718843336;3661.340958627446;3666.4866918631415;5287.726277700587;5343.706096164709;5344.545713614348;5351.170568561879;5372.382176049726;3710.424884142962;3721.553413590332;3722.088088418355;3722.4602432647116;3739.8317075731657;3756.1736417988;3780.905477363088;3786.1291902861944;3794.6015668354426;3795.772253664789;4054.1688953764406;4317.0934103838545;4321.459817522809;4321.870343889688;4323.546027667113;5082.923756143661;5096.337476128154;5101.311322971425;5125.56432703217;5132.692038477703;1232.2544860359533;1269.0672355818467;1271.5549557654747;1293.1659079893416;1313.8423389193358;850.2093053460218;869.9434536755091;875.4965894610497;897.241830653097;913.6528119314618;4438.644908407384;4442;4452.621527170227;4453.755043472575;4455.242608756519;5227.3465816772905;5248.897731476432;5259.158534634516;5264.684118952875;5264.947350526522;4354.9564504355185;4556.931646025312;4585.174668559691;4586.3579098926175;4587.655925805578;2780.958285625717;2818.788590855653;2824.971750282471;2830.2924268932766;2837.730415610514;4742.407199100113;4942.838432968249;4954.405471343462;4977.676451030671;4983.181138884281;5359.330083739533;5362.570994320445;5378.1663842104535;5386.946130538723;5401.648892821954;4874.512548745097;4908.754562271872;4924.704517728947;4969.0807200668;4970.975145124251;5088.414832294334;5224.197651810119;5244.344456942882;5247.265382846481;5269.446708095595;5105.821296254762;5118.692878427306;5135.071670172396;5135.204043373283;5141.588672906233;4850.95149048505;4903.8528844134735;4929.756960582998;4952.77712502931;4970.7514624267915;3625;3693.9261214775015;3713.1274150574054;3725.7578257413184;3726.9813650931574;5196.506331898464;5215.374155101412;5227.4249832517635;5236;5271.8682032947945;4980.825671101494;4992.850214493571;5042.14283571801;5066.41736200327;5067.41724701664;4799.760011999316;4987.576056035133;5007.674501157413;5016.372953380827;5017.749112544431;4731.29030645406;4799.688020278671;4905.1416002200185;4922.72924989129;4953.801847926043;4988.351514303117;5011.544343271844;5020;5032.572231360229;5042.571381432619;4878.317035615088;4879.829205977774;4890.902181956412;4891.559759621651;4908.361912951436 12:18:16 INFO - PROCESS | 30009 | |5;yui.html;669.6417416682075;721.722136977264;726.963651817409;750.2385079144673;753.1150897695206;11823.586174483895;12607.810882836764;12639.55761548346;12641;12641.747165056693;12070.577529786458;12262.693432664166;12277.14060015797;12281.342018827478;12304.446299916503;616.9629822210659;752.5296689569019;760.3726925286633;784.4038530716668;788.6056971514242;773.5745340062971;787.4723934963588;787.8660627693306;787.873940169573;788.2984144111745;843.1357858195338;848.1264297773304;848.6011574559947;848.6138806842872;848.9066202717727;640.1358166475268;787.0673252196166;816.2857499687773;835.2107258640588;835.4277320035795;607.3531688751509;608.191105829246;608.9360617135226;608.939106089392;609.0468416927495;13498.190108593515;13510.594682159453;13522.459101635923;13528.526501572496;13534.796978045239;12570.811437828439;12707.872921270762;13035;13052.738945221043;13197.604071877859;11782.410879456078;11788.17482776206;11837.704057398549;11844.230125041844;12203.145779795417;3275.4922986937063;3349.2129349602824;3371.342588195303;3440.707539859115;4190.706650534464;53824.73087634576;55098;55176.172357414674;61050;61062;10595.894041059644;10817.675469735921;11115.499802508906;11344.773104538028;11431.371274579811;21142.78857211439;21170.78829211719;21761.891190544262;21838.344849654535;21843.235486757887;7200.351968322771;7271.418286537064;7319.707211711579;7336.669849856769;7506.197915111;3734.3651579231596;3840.7503512271614;3860.2665493556697;3922.5685174630767;3956.604339566078;2926.0929111975356;3030.7423868971387;3033.6056312679652;3033.7876348655823;3034.863431145604;516.8630312967067;536.3858382152414;542.4250294687644;545.1522881918576;549.6262541471838;511.81063006687765;513.5147285814944;593.7981086430634;602.3103546439303;608.8295277322356;7816.8827467588035;7849.332806711379;8052.463474005669;8099.149589293157;8158.755237342889;502.3670175578797;545.7598656591088;588.3821986913723;616.3559080760616;632.8892443822405;3468.6878180963836;3700.648438398348;3786.3752480840903;3807.162424266657;3903.2388684206876;55277.447225528034;79022.6048869752;93180.53409732907;98832.50583747035;100110.4994475023;84615;87224.5638771802;87461;87508;87853;47071.764641176575;59237.703811480664;66573;73680.26319736734;75481.62259188779;7094.290570942864;7101.396381307647;7208.603526806076;7325.633718313957;7369.668364923698;36302.27395452129;42722.359164613175;43628.345574815765;43705.56294437015;44333.77833110814;56817.71591142018;57258.427415726976;61194.71636985368;65333.673331633036;65996.67001664962;10474.895251047697;10538.525766340686;10624.468776561296;10755.139588833032;11440.771184576428;12855.614331570068;13065.281409522568;13250.9399248058;13372.063955523408;13493.662658433617;12020.459079341275;12241;12532.436040378387;12812.935935320264;13238.073334866853;12153.1492795507;12373.876261237632;12433.254004759743;12489.687757806127;12720.618381448572;10966.342019478856;11430.828537571777;11615.76768464643;11805.055595552163;11910.583129590423;10401.94799026;10650.467476625983;11052.502637381176;11336.6032188873;11370.658880233606;9751.3661611995;9771.657991970247;10230.744231394274;10238.385696858213;10322.48387580633 12:18:16 INFO - PROCESS | 30009 | __end_tp_report 12:18:16 INFO - PROCESS | 30009 | __start_cc_report 12:18:16 INFO - PROCESS | 30009 | _x_x_mozilla_cycle_collect,1069 12:18:16 INFO - PROCESS | 30009 | __end_cc_report 12:18:16 INFO - PROCESS | 30009 | __startTimestamp1468955896590__endTimestamp 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | ------- Summary: start ------- 12:18:16 INFO - PROCESS | 30009 | Number of tests: 6 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#0] dojo.html Cycles:165 Average:4642.40 Median:4738.22 stddev:496.68 (10.5%) stddev-sans-first:470.19 12:18:16 INFO - PROCESS | 30009 | Values: 2546.2 2557.9 2590.9 2596.4 2597.1 4570.5 4615.0 4667.5 4683.6 4698.2 4675.8 4683.4 4765.9 4766.7 4793.5 4121.8 4230.1 4339.4 4367.2 4500.3 4404.8 4444.1 4455.1 4467.8 4488.1 4226.8 4261.1 4288.4 4292.7 4301.2 4203.8 4210.4 4219.3 4255.5 4271.9 4266.3 4271.2 4282.9 4311.5 4329.4 4547.3 4673.5 4689.9 4705.9 4718.0 5015.2 5073.9 5079.9 5080.7 5081.0 5061.3 5114.3 5126.9 5127.8 5128.8 4548.4 4681.7 4752.3 4752.8 4756.9 5188.5 5212.9 5219.0 5220.1 5226.1 4991.4 4992.8 4994.2 4995.0 5002.6 4808.2 5022.0 5052.6 5056.1 5077.3 5046.7 5050.9 5052.5 5078.9 5096.4 5019.5 5024.1 5027.3 5031.3 5076.3 4157.1 4199.1 4255.7 4327.9 4372.7 3726.5 3751.1 3755.6 3783.6 3807.2 4345.4 4374.0 4378.3 4412.5 4421.1 4894.4 4948.0 4992.5 5101.2 5118.7 4316.1 4346.7 4352.0 4361.4 4394.6 4529.8 4549.6 4550.2 4559.0 4583.2 4521.5 4714.2 4717.6 4738.2 4760.5 5056.7 5074.6 5079.6 5082.6 5117.8 4755.4 4767.4 4767.6 4768.4 4805.0 4803.1 4948.7 4980.4 5004.9 5024.7 5082.3 5100.2 5103.5 5110.2 5154.9 4878.2 4883.3 4887.6 4890.6 4933.4 4681.2 4689.8 4710.8 4714.8 4772.2 4701.1 4703.1 4718.4 4767.9 4772.6 4739.7 4808.7 4817.6 4820.3 4842.8 4678.9 4681.7 4729.3 4761.6 4806.3 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#1] ext.html Cycles:180 Average:49184.26 Median:3386.04 stddev:89335.37 (2638.3%) stddev-sans-first:89511.35 12:18:16 INFO - PROCESS | 30009 | Values: 548.5 576.9 581.2 590.1 599.0 27023.6 39433.8 40166.4 40246.2 40286.6 41682.6 41925.0 41934.6 42172.0 42205.2 7480.9 7626.6 7627.1 7855.8 8010.3 7601.7 10356.6 10719.8 10721.2 10722.4 10396.0 10428.3 10430.6 10453.2 10457.0 7645.9 7884.3 10308.3 10380.1 10387.5 7624.4 9828.5 10172.4 10178.2 10563.6 38709.0 39188.6 39203.2 39218.2 39230.2 3033.3 3106.3 3130.5 3147.9 3552.0 29834.1 30063.5 30066.2 30463.8 30566.2 3377.6 3394.5 3414.5 3419.3 3442.4 265373.0 270104.0 270449.0 271362.0 271890.0 56499.7 56888.4 56979.4 56991.4 57066.9 58535.0 58645.4 58854.7 59054.1 59064.7 14686.4 15082.4 15127.8 15128.9 15136.7 10070.3 10163.2 10221.5 11186.2 11360.9 18173.9 18446.2 18470.5 18470.5 18511.5 6863.3 6886.5 6998.6 7055.0 7059.8 781.9 875.3 926.3 960.6 1003.7 27345.3 27680.3 28579.0 28585.4 28758.9 991.7 1000.6 1015.9 1036.8 1046.5 14757.4 15217.5 15227.8 15256.4 15380.4 414368.0 418144.0 418391.0 418564.0 418743.0 49109.5 50157.7 50166.5 50177.0 50323.0 1055.4 1151.5 1161.7 1186.1 1200.9 27969.3 29030.3 29129.6 29894.9 29939.4 41383.0 41734.6 41854.6 41929.8 42024.4 311560.0 312272.0 313247.0 313329.0 313879.0 23350.9 24048.5 24490.1 25071.0 25311.2 42051.6 42086.0 42146.0 43049.0 43393.0 35594.6 35721.8 36174.0 36301.0 36646.6 36612.8 36756.4 36789.8 37086.4 37103.3 34692.3 35305.5 35827.9 35912.6 35933.1 30576.5 32555.5 32733.7 32752.2 32947.5 24640.0 25255.7 25341.6 25564.7 25588.0 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#2] jquery.html Cycles:180 Average:24448.25 Median:2185.63 stddev:64479.01 (2950.1%) stddev-sans-first:64634.50 12:18:16 INFO - PROCESS | 30009 | Values: 346.6 372.8 379.0 381.3 391.8 13180.9 16758.8 17168.3 18412.8 18413.8 16996.2 17017.7 18081.9 18083.7 18131.4 4903.0 5218.9 5224.1 5231.3 5240.3 3807.9 3979.4 3983.4 4032.4 5058.8 5746.6 6039.6 6050.5 6146.5 6155.4 6051.3 6053.6 6168.0 6193.3 6194.7 5236.7 5387.3 5387.4 5393.1 5413.0 18185.1 18249.2 18258.4 18920.0 21896.0 1918.5 1937.5 1945.0 1958.5 1961.5 13140.6 13349.5 13665.2 13850.9 14265.6 1690.6 1699.7 1763.3 1834.9 1844.8 70527.3 71177.6 71665.6 72134.3 72505.3 8470.3 9238.2 9520.4 9584.8 10144.9 11989.8 12768.4 12783.2 13107.1 13149.7 7051.8 7093.1 7302.9 7326.5 7334.2 6805.7 6817.1 6876.7 6936.9 6961.5 6281.9 6331.9 6384.7 6413.5 6438.2 1696.0 1777.2 1789.3 1789.7 1842.5 771.1 903.9 909.6 914.7 925.3 17584.2 17846.4 18380.4 18483.0 18885.2 883.4 885.2 889.0 925.4 933.0 9600.9 9752.1 10373.2 10491.6 10561.5 384380.0 384656.0 388731.0 399295.0 399957.0 68579.3 70568.0 71416.0 72253.3 72880.0 893.5 934.3 957.5 960.4 962.5 16515.7 16595.5 16762.2 16949.6 17071.9 23906.5 36832.0 37948.0 38262.4 40172.6 48487.0 50096.0 50263.7 50311.0 50397.7 7341.7 7482.6 7649.1 7682.9 7899.3 10373.8 11922.3 12209.2 12342.3 12505.2 10594.3 10683.7 10702.5 10878.1 10912.9 10448.2 10996.9 11016.7 11260.7 11497.5 10190.6 10209.5 10727.9 10986.3 11413.5 7544.0 7600.7 7733.8 7792.8 7913.4 9811.0 10564.5 10626.5 10674.7 10835.1 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#3] mootools.html Cycles:180 Average:5121.02 Median:5135.59 stddev:2864.70 (55.8%) stddev-sans-first:2858.17 12:18:16 INFO - PROCESS | 30009 | Values: 1276.8 1386.2 1396.9 1679.3 1711.4 7484.1 7833.7 8009.5 8016.1 8020.6 6533.1 7499.1 7656.0 7673.0 7839.3 2205.4 2228.0 2233.1 2233.5 2239.5 2199.9 2243.8 2271.5 2271.8 2273.3 1846.5 1913.0 1913.7 1914.8 2149.8 2167.5 2192.8 2195.3 2196.1 2197.8 2162.9 2201.4 2211.4 2250.0 2255.5 6561.4 7414.4 7590.4 7877.2 7940.2 4610.3 4760.3 4766.7 4767.6 4768.5 2815.1 2877.8 2900.3 2931.6 2945.9 922.1 922.3 940.2 944.9 952.4 10261.6 10325.2 10331.7 10334.5 10335.3 4137.5 4236.9 4367.9 4377.6 4408.7 8733.9 8776.3 8801.8 8805.0 8805.8 4604.8 4604.9 4606.7 4607.2 4607.6 4148.1 4192.6 4209.2 4209.6 4301.5 3616.8 3667.9 3702.3 3720.9 3737.7 1195.9 1224.6 1224.9 1232.5 1247.8 724.7 738.9 853.4 857.4 865.0 5090.6 5215.5 5250.4 5271.8 5299.7 407.1 413.5 414.6 421.6 424.0 3549.2 3562.2 3601.4 3620.1 3624.7 9213.4 9603.8 9715.1 9724.8 9744.5 9644.1 9649.3 9649.5 9659.1 9671.9 7182.9 7284.2 7375.1 7375.4 7384.8 5233.2 5253.2 5267.4 5291.2 5307.2 8872.4 8929.2 9042.0 9092.5 9158.5 8907.8 9098.1 9125.8 9310.4 9310.5 6792.2 6837.2 6856.6 6860.3 6885.2 7219.7 7496.7 7498.1 7697.5 7706.6 5180.5 6401.6 6671.4 6771.1 6930.9 6550.2 6570.6 6642.4 7017.4 7028.5 6428.5 6496.2 6499.1 6503.0 6507.6 4557.6 4586.5 4611.6 4691.9 4770.2 4793.9 4800.5 4815.0 4841.7 4886.5 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#4] prototype.html Cycles:180 Average:4221.29 Median:4799.72 stddev:1214.92 (25.3%) stddev-sans-first:1182.11 12:18:16 INFO - PROCESS | 30009 | Values: 298.2 301.3 308.4 309.9 312.0 4790.9 4848.1 4879.2 4879.5 4912.9 4582.0 4665.5 4736.2 4820.2 4858.9 3808.4 3826.5 3849.0 3849.2 3850.7 3851.2 3861.7 3879.7 3882.0 3891.8 3635.1 3710.0 3812.4 3827.0 3844.4 3781.9 3794.6 3815.4 3824.3 3826.5 3406.2 3412.5 3420.9 3421.9 3434.3 4519.3 4742.4 4772.8 4795.0 4803.8 4231.4 4302.7 4303.0 4303.5 4323.0 5064.7 5072.6 5090.4 5100.7 5105.8 3575.8 3636.4 3653.3 3661.3 3666.5 5287.7 5343.7 5344.5 5351.2 5372.4 3710.4 3721.6 3722.1 3722.5 3739.8 3756.2 3780.9 3786.1 3794.6 3795.8 4054.2 4317.1 4321.5 4321.9 4323.5 5082.9 5096.3 5101.3 5125.6 5132.7 1232.3 1269.1 1271.6 1293.2 1313.8 850.2 869.9 875.5 897.2 913.7 4438.6 4442.0 4452.6 4453.8 4455.2 5227.3 5248.9 5259.2 5264.7 5264.9 4355.0 4556.9 4585.2 4586.4 4587.7 2781.0 2818.8 2825.0 2830.3 2837.7 4742.4 4942.8 4954.4 4977.7 4983.2 5359.3 5362.6 5378.2 5386.9 5401.6 4874.5 4908.8 4924.7 4969.1 4971.0 5088.4 5224.2 5244.3 5247.3 5269.4 5105.8 5118.7 5135.1 5135.2 5141.6 4851.0 4903.9 4929.8 4952.8 4970.8 3625.0 3693.9 3713.1 3725.8 3727.0 5196.5 5215.4 5227.4 5236.0 5271.9 4980.8 4992.9 5042.1 5066.4 5067.4 4799.8 4987.6 5007.7 5016.4 5017.7 4731.3 4799.7 4905.1 4922.7 4953.8 4988.4 5011.5 5020.0 5032.6 5042.6 4878.3 4879.8 4890.9 4891.6 4908.4 12:18:16 INFO - PROCESS | 30009 | 12:18:16 INFO - PROCESS | 30009 | [#5] yui.html Cycles:180 Average:17149.06 Median:43175.35 stddev:23750.99 (55.0%) stddev-sans-first:23785.39 12:18:16 INFO - PROCESS | 30009 | Values: 669.6 721.7 727.0 750.2 753.1 11823.6 12607.8 12639.6 12641.0 12641.7 12070.6 12262.7 12277.1 12281.3 12304.4 617.0 752.5 760.4 784.4 788.6 773.6 787.5 787.9 787.9 788.3 843.1 848.1 848.6 848.6 848.9 640.1 787.1 816.3 835.2 835.4 607.4 608.2 608.9 608.9 609.0 13498.2 13510.6 13522.5 13528.5 13534.8 12570.8 12707.9 13035.0 13052.7 13197.6 11782.4 11788.2 11837.7 11844.2 12203.1 3275.5 3349.2 3371.3 3440.7 4190.7 53824.7 55098.0 55176.2 61050.0 61062.0 10595.9 10817.7 11115.5 11344.8 11431.4 21142.8 21170.8 21761.9 21838.3 21843.2 7200.4 7271.4 7319.7 7336.7 7506.2 3734.4 3840.8 3860.3 3922.6 3956.6 2926.1 3030.7 3033.6 3033.8 3034.9 516.9 536.4 542.4 545.2 549.6 511.8 513.5 593.8 602.3 608.8 7816.9 7849.3 8052.5 8099.1 8158.8 502.4 545.8 588.4 616.4 632.9 3468.7 3700.6 3786.4 3807.2 3903.2 55277.4 79022.6 93180.5 98832.5 100110.5 84615.0 87224.6 87461.0 87508.0 87853.0 47071.8 59237.7 66573.0 73680.3 75481.6 7094.3 7101.4 7208.6 7325.6 7369.7 36302.3 42722.4 43628.3 43705.6 44333.8 56817.7 57258.4 61194.7 65333.7 65996.7 10474.9 10538.5 10624.5 10755.1 11440.8 12855.6 13065.3 13250.9 13372.1 13493.7 12020.5 12241.0 12532.4 12812.9 13238.1 12153.1 12373.9 12433.3 12489.7 12720.6 10966.3 11430.8 11615.8 11805.1 11910.6 10401.9 10650.5 11052.5 11336.6 11370.7 9751.4 9771.7 10230.7 10238.4 10322.5 12:18:16 INFO - PROCESS | 30009 | -------- Summary: end -------- 12:18:16 INFO - PROCESS | 30009 | 12:18:17 INFO - TEST-INFO | 30009: exit 0 12:18:17 INFO - TEST-OK | dromaeo_css | took 1119070ms 12:18:17 INFO - TEST-START | kraken 12:18:17 INFO - operating with platform_type : linux_ 12:18:17 INFO - Initialising browser for kraken test... 12:18:17 INFO - TEST-INFO | started process 30200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxh_3SC/profile http://localhost:49070/getInfo.html) 12:18:21 INFO - PROCESS | 30200 | __metrics Screen width/height:1600/1200 12:18:21 INFO - PROCESS | 30200 | colorDepth:24 12:18:21 INFO - PROCESS | 30200 | Browser inner width/height: 1024/697 12:18:21 INFO - PROCESS | 30200 | __metrics 12:18:22 INFO - PROCESS | 30200 | 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" 12:18:22 INFO - PROCESS | 30200 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:23 INFO - TEST-INFO | 30200: exit 0 12:18:23 INFO - Browser initialized. 12:18:23 INFO - Running cycle 1/1 for kraken test... 12:18:23 INFO - TEST-INFO | started process 30281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxh_3SC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:35 INFO - PROCESS | 30281 | RSS: Main: 159301632 12:18:35 INFO - PROCESS | 30281 | 12:18:37 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49070/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:38 INFO - PROCESS | 30281 | RSS: Main: 217927680 12:18:38 INFO - PROCESS | 30281 | 12:18:41 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49070/tests/kraken/driver.html?testName=audio-dft) 12:18:42 INFO - PROCESS | 30281 | RSS: Main: 207298560 12:18:42 INFO - PROCESS | 30281 | 12:18:45 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49070/tests/kraken/driver.html?testName=audio-fft) 12:18:45 INFO - PROCESS | 30281 | RSS: Main: 271577088 12:18:45 INFO - PROCESS | 30281 | 12:18:48 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49070/tests/kraken/driver.html?testName=audio-oscillator) 12:18:48 INFO - PROCESS | 30281 | RSS: Main: 182288384 12:18:48 INFO - PROCESS | 30281 | 12:18:50 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:18:51 INFO - PROCESS | 30281 | RSS: Main: 186159104 12:18:51 INFO - PROCESS | 30281 | 12:18:54 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49070/tests/kraken/driver.html?testName=imaging-darkroom) 12:18:55 INFO - PROCESS | 30281 | RSS: Main: 222310400 12:18:55 INFO - PROCESS | 30281 | 12:18:58 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49070/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:59 INFO - PROCESS | 30281 | RSS: Main: 222687232 12:18:59 INFO - PROCESS | 30281 | 12:19:02 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49070/tests/kraken/driver.html?testName=json-parse-financial) 12:19:02 INFO - PROCESS | 30281 | RSS: Main: 222691328 12:19:02 INFO - PROCESS | 30281 | 12:19:04 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:05 INFO - PROCESS | 30281 | RSS: Main: 212406272 12:19:05 INFO - PROCESS | 30281 | 12:19:07 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:07 INFO - PROCESS | 30281 | RSS: Main: 215670784 12:19:07 INFO - PROCESS | 30281 | 12:19:09 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:10 INFO - PROCESS | 30281 | RSS: Main: 213061632 12:19:10 INFO - PROCESS | 30281 | 12:19:13 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:13 INFO - PROCESS | 30281 | RSS: Main: 233172992 12:19:13 INFO - PROCESS | 30281 | 12:19:16 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:17 INFO - PROCESS | 30281 | RSS: Main: 226668544 12:19:17 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | Cycle 1(1): loaded http://localhost:49070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49070/tests/kraken/driver.html?testName=ai-astar) 12:19:19 INFO - PROCESS | 30281 | RSS: Main: 268673024 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | __start_tp_report 12:19:19 INFO - PROCESS | 30281 | _x_x_mozilla_page_load 12:19:19 INFO - PROCESS | 30281 | _x_x_mozilla_page_load_details 12:19:19 INFO - PROCESS | 30281 | |i|pagename|runs| 12:19:19 INFO - PROCESS | 30281 | |0;ai-astar;105;114;115;113;115;115;114;112;114;113 12:19:19 INFO - PROCESS | 30281 | |1;audio-beat-detection;146;123;127;169;122;144;145;129;181;124 12:19:19 INFO - PROCESS | 30281 | |2;audio-dft;162;160;160;160;163;162;162;162;162;161 12:19:19 INFO - PROCESS | 30281 | |3;audio-fft;76;76;75;109;77;77;75;76;103;74 12:19:19 INFO - PROCESS | 30281 | |4;audio-oscillator;85;86;116;84;85;85;125;84;84;123 12:19:19 INFO - PROCESS | 30281 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 12:19:19 INFO - PROCESS | 30281 | |6;imaging-darkroom;148;146;146;146;146;146;146;146;146;146 12:19:19 INFO - PROCESS | 30281 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;99 12:19:19 INFO - PROCESS | 30281 | |8;json-parse-financial;65;64;64;62;63;63;64;63;67;63 12:19:19 INFO - PROCESS | 30281 | |9;json-stringify-tinderbox;67;67;66;66;66;66;66;65;67;67 12:19:19 INFO - PROCESS | 30281 | |10;stanford-crypto-aes;79;79;84;87;82;78;78;86;79;82 12:19:19 INFO - PROCESS | 30281 | |11;stanford-crypto-ccm;139;137;136;137;135;129;130;130;166;133 12:19:19 INFO - PROCESS | 30281 | |12;stanford-crypto-pbkdf2;168;165;164;169;160;161;162;162;160;168 12:19:19 INFO - PROCESS | 30281 | |13;stanford-crypto-sha256-iterative;68;69;67;65;65;66;64;76;64;65 12:19:19 INFO - PROCESS | 30281 | __end_tp_report 12:19:19 INFO - PROCESS | 30281 | __start_cc_report 12:19:19 INFO - PROCESS | 30281 | _x_x_mozilla_cycle_collect,1923 12:19:19 INFO - PROCESS | 30281 | __end_cc_report 12:19:19 INFO - PROCESS | 30281 | __startTimestamp1468955959300__endTimestamp 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | ------- Summary: start ------- 12:19:19 INFO - PROCESS | 30281 | Number of tests: 14 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 12:19:19 INFO - PROCESS | 30281 | Values: 105.0 114.0 115.0 113.0 115.0 115.0 114.0 112.0 114.0 113.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:144.50 stddev:20.41 (14.1%) stddev-sans-first:21.56 12:19:19 INFO - PROCESS | 30281 | Values: 146.0 123.0 127.0 169.0 122.0 144.0 145.0 129.0 181.0 124.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 12:19:19 INFO - PROCESS | 30281 | Values: 162.0 160.0 160.0 160.0 163.0 162.0 162.0 162.0 162.0 161.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.87 (16.9%) stddev-sans-first:13.47 12:19:19 INFO - PROCESS | 30281 | Values: 76.0 76.0 75.0 109.0 77.0 77.0 75.0 76.0 103.0 74.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.50 stddev:17.84 (21.1%) stddev-sans-first:18.50 12:19:19 INFO - PROCESS | 30281 | Values: 85.0 86.0 116.0 84.0 85.0 85.0 125.0 84.0 84.0 123.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:19:19 INFO - PROCESS | 30281 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.00 12:19:19 INFO - PROCESS | 30281 | Values: 148.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.27 (1.3%) stddev-sans-first:1.33 12:19:19 INFO - PROCESS | 30281 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 99.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.41 12:19:19 INFO - PROCESS | 30281 | Values: 65.0 64.0 64.0 62.0 63.0 63.0 64.0 63.0 67.0 63.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 12:19:19 INFO - PROCESS | 30281 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 66.0 65.0 67.0 67.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:3.34 (4.1%) stddev-sans-first:3.43 12:19:19 INFO - PROCESS | 30281 | Values: 79.0 79.0 84.0 87.0 82.0 78.0 78.0 86.0 79.0 82.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.50 stddev:10.69 (7.8%) stddev-sans-first:11.31 12:19:19 INFO - PROCESS | 30281 | Values: 139.0 137.0 136.0 137.0 135.0 129.0 130.0 130.0 166.0 133.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:3.45 (2.1%) stddev-sans-first:3.32 12:19:19 INFO - PROCESS | 30281 | Values: 168.0 165.0 164.0 169.0 160.0 161.0 162.0 162.0 160.0 168.0 12:19:19 INFO - PROCESS | 30281 | 12:19:19 INFO - PROCESS | 30281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:3.60 (5.4%) stddev-sans-first:3.80 12:19:19 INFO - PROCESS | 30281 | Values: 68.0 69.0 67.0 65.0 65.0 66.0 64.0 76.0 64.0 65.0 12:19:19 INFO - PROCESS | 30281 | -------- Summary: end -------- 12:19:19 INFO - PROCESS | 30281 | 12:19:20 INFO - TEST-INFO | 30281: exit 0 12:19:20 INFO - TEST-OK | kraken | took 62887ms 12:19:20 INFO - SUITE-END | took 1181s 12:19:20 INFO - Completed test suite (00:19:42) 12:19:20 INFO - javascript benchmark 12:19:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2546.2488565873064, 2557.8721063946796, 2590.9481810363786, 2596.4028273497097, 2597.103999120304, 4570.542945705428, 4615.0, 4667.463241727202, 4683.5550622690835, 4698.248280275152, 4675.789589468473, 4683.391159149314, 4765.90468190636, 4766.73782941938, 4793.496682848303, 4121.835126594932, 4230.069384735353, 4339.435873336462, 4367.213901497729, 4500.302453119772, 4404.8017839197155, 4444.133393988173, 4455.1089782043555, 4467.798949047285, 4488.102379524092, 4226.830926762926, 4261.147770445892, 4288.4210631564965, 4292.678049146295, 4301.225779359714, 4203.7687927164, 4210.389493523422, 4219.261629214875, 4255.531891491964, 4271.8718438446895, 4266.338717498762, 4271.231178387889, 4282.914341713148, 4311.547287534827, 4329.350597410382, 4547.272436410191, 4673.509281525425, 4689.929651055237, 4705.929411058837, 4718.032803275355, 5015.172496538067, 5073.898522029539, 5079.873003174913, 5080.720560369178, 5081.034603425337, 5061.316722242487, 5114.309568208281, 5126.897462050738, 5127.820526281562, 5128.769205385766, 4548.431446069274, 4681.6722829401615, 4752.263399173134, 4752.833650822205, 4756.881077973078, 5188.481151884856, 5212.947870521246, 5219.034478621391, 5220.086484865134, 5226.085435048852, 4991.3511243538105, 4992.775325110306, 4994.200927851526, 4995.0, 5002.59979201663, 4808.206645903457, 5022.0, 5052.646314757932, 5056.115179843586, 5077.314562534085, 5046.722430266297, 5050.9494905051215, 5052.469490703496, 5078.873028174326, 5096.362954630671, 5019.52314530119, 5024.145895197825, 5027.321311622884, 5031.270465782514, 5076.340075790197, 4157.064660451374, 4199.076203235283, 4255.659547236276, 4327.870163895088, 4372.7376357418025, 3726.459663348799, 3751.118487155516, 3755.5681096673684, 3783.621637836194, 3807.2385522895534, 4345.391645169679, 4374.0, 4378.343248512685, 4412.514623391425, 4421.115776844644, 4894.388201474816, 4948.035133149001, 4992.475790041994, 5101.234814777738, 5118.744062796845, 4316.115196384733, 4346.695731298842, 4351.956480435155, 4361.433013708261, 4394.604485596312, 4529.773511324421, 4549.567791059844, 4550.180967425829, 4559.0, 4583.220852455091, 4521.525239849769, 4714.198586240416, 4717.575418212377, 4738.218193997952, 4760.523947605212, 5056.650442830856, 5074.644774865724, 5079.593632509316, 5082.618803589819, 5117.820876269313, 4755.38180036593, 4767.427908650984, 4767.594754445772, 4768.380110585602, 4804.95195048045, 4803.087413391444, 4948.653594248368, 4980.352554167935, 5004.899902001866, 5024.698518088926, 5082.33929589151, 5100.183970564692, 5103.515166059218, 5110.1568241239775, 5154.922676159786, 4878.170710979213, 4883.291922671264, 4887.560119589254, 4890.608751299958, 4933.407991041098, 4681.204195286878, 4689.835855745033, 4710.788014539423, 4714.834980775657, 4772.212584923587, 4701.059788042337, 4703.082898834831, 4718.41019872516, 4767.928481072718, 4772.570468657837, 4739.668223224341, 4808.663393562417, 4817.638677099161, 4820.276958456259, 4842.7578621068105, 4678.906421871611, 4681.695689780154, 4729.314249433882, 4761.6428767843245, 4806.279058141306], "value": 4609.972031210304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5222193620856, 576.8875069361471, 581.2414798687712, 590.1413443439795, 599.0116308091647, 27023.594646080324, 39433.80283098584, 40166.39750403739, 40246.19507609846, 40286.59713402861, 41682.58317416825, 41925.0, 41934.58065419345, 42172.0, 42205.15589688212, 7480.850382992364, 7626.580538070404, 7627.122880868688, 7855.842883142348, 8010.279074883259, 7601.695932162706, 10356.637517686882, 10719.83920241197, 10721.195910306758, 10722.35665860047, 10396.0, 10428.270021098526, 10430.63492777753, 10453.216008799332, 10457.0, 7645.891345754834, 7884.32983196429, 10308.32995855267, 10380.11768999636, 10387.532561034734, 7624.390048796083, 9828.459434731158, 10172.44051577163, 10178.236632252536, 10563.63027294041, 38709.0, 39188.60811391878, 39203.215935681415, 39218.21563568713, 39230.21539569221, 3033.2871775132826, 3106.301082256497, 3130.546070819741, 3147.921301967446, 3552.0231936217747, 29834.10497685073, 30063.549046764096, 30066.24834379136, 30463.847680761675, 30566.235844104074, 3377.628460869302, 3394.4568868980846, 3414.5219669246326, 3419.3161367726307, 3442.4492081267126, 265373.0, 270104.0, 270449.0, 271361.999999998, 271890.0, 56499.71750141223, 56888.43111568914, 56979.43020569824, 56991.430085699445, 57066.85866282651, 58535.0, 58645.413545863994, 58854.7057264711, 59054.11418828721, 59064.70467647634, 14686.412543498354, 15082.396704131712, 15127.773083403757, 15128.924355378153, 15136.697266054618, 10070.345427547332, 10163.186945044527, 10221.488925553693, 11186.16103792219, 11360.886391136148, 18173.90913045453, 18446.169922353525, 18470.538236543925, 18470.538236543925, 18511.53721156982, 6863.347981941708, 6886.51794374389, 6998.62046904055, 7055.0, 7059.82350441243, 781.9491733037335, 875.2691502595277, 926.333040211047, 960.6109525642127, 1003.693873368615, 27345.316367090585, 27680.307992300353, 28579.0, 28585.428291434055, 28758.85620571884, 991.7223177510309, 1000.6097621927454, 1015.9339642923186, 1036.8185567525652, 1046.4663021858755, 14757.40970361195, 15217.467388641344, 15227.771583426258, 15256.389744410099, 15380.38478460849, 414368.0, 418144.0, 418391.0, 418564.0, 418743.0, 49109.50890491121, 50157.74921125371, 50166.49833501691, 50177.0, 50323.0, 1055.37205362809, 1151.4875880233383, 1161.703765539799, 1186.1281957761212, 1200.855897292313, 27969.300767480974, 29030.27424314409, 29129.56305655459, 29894.85052574723, 29939.401211976074, 41383.0, 41734.58265417307, 41854.58145418507, 41929.79035104805, 42024.36963445612, 311560.0, 312272.0, 313247.0, 313329.0, 313879.0, 23350.883245583664, 24048.51902961966, 24490.14284500034, 25071.0, 25311.240662780147, 42051.57948420477, 42086.0, 42146.0, 43049.0, 43393.0, 35594.64405355913, 35721.82139089288, 36174.0, 36301.0, 36646.633533664324, 36612.81693591515, 36756.44865327076, 36789.81605091957, 37086.44370334393, 37103.257934840614, 34692.30615387628, 35305.47041794426, 35827.92516224518, 35912.640873591976, 35933.1016724584, 30576.541351879296, 32555.511667324536, 32733.67266327306, 32752.181195470304, 32947.50578741273, 24640.0, 25255.74744252534, 25341.57788869909, 25564.744352556238, 25588.0], "value": 18200.990146419033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6377635371037, 372.7781969728011, 378.9905252368691, 381.2774791769595, 391.8491380818384, 13180.934095329521, 16758.83241167588, 17168.3132674693, 18412.81587184131, 18413.815861841376, 16996.235169417374, 17017.74473382897, 18081.90959045203, 18083.728744068816, 18131.365402210926, 4902.950970490294, 5218.921716174261, 5224.085784987631, 5231.267622532849, 5240.266362709223, 3807.923841523168, 3979.403089536578, 3983.4024896265646, 4032.354823228284, 5058.772355244005, 5746.626469279504, 6039.5772295939305, 6050.515958723292, 6146.508279337642, 6155.446009859112, 6051.281538945698, 6053.636781793107, 6168.0, 6193.318734939153, 6194.659293738842, 5236.659617124913, 5387.272718183034, 5387.4073851876265, 5393.1370980642905, 5412.99859525989, 18185.090745462672, 18249.17878695462, 18258.36095736656, 18919.95940223287, 21896.0, 1918.5491409518752, 1937.4865660599953, 1945.046927005771, 1958.5299528113292, 1961.4507937777446, 13140.60578182656, 13349.466021359134, 13665.18008919468, 13850.861491385158, 14265.57203283903, 1690.6365131496786, 1699.6855581717423, 1763.3299346248343, 1834.871558990871, 1844.8431883289936, 70527.29472705259, 71177.64411177962, 71665.64167179183, 72134.27865721328, 72505.27494725038, 8470.280026197843, 9238.168564829197, 9520.428774273565, 9584.808303833885, 10144.898551014396, 11989.760204795855, 12768.361581920866, 12783.16909400886, 13107.082504224803, 13149.671258218621, 7051.753188638373, 7093.077899872984, 7302.890456643155, 7326.523775954546, 7334.193238743734, 6805.6597170141295, 6817.113775209191, 6876.69054892531, 6936.895946560806, 6961.512694111364, 6281.905771413432, 6331.873362532723, 6384.744610215539, 6413.486921046305, 6438.195225596801, 1695.9576010599833, 1777.173614269371, 1789.3021721528614, 1789.731540268944, 1842.4519625145933, 771.1034928205848, 903.8623655055745, 909.6225066597289, 914.6752902719572, 925.3476299209042, 17584.208710608054, 17846.375376861746, 18380.356687515872, 18483.0, 18885.150168242188, 883.3816328570026, 885.203317014692, 889.0, 925.4123631493915, 932.9720108396759, 9600.903990960142, 9752.073553012453, 10373.222008349405, 10491.632792852366, 10561.524731387106, 384380.0, 384656.0, 388731.0, 399295.0, 399957.0, 68579.3142068583, 70568.0, 71416.0, 72253.27746722571, 72880.0, 893.5130353957109, 934.2806039349798, 957.5355952363099, 960.4045491795132, 962.4898803634085, 16515.66968660644, 16595.50213493597, 16762.245698943334, 16949.559167516265, 17071.91464042672, 23906.52186956286, 36832.0, 37948.0, 38262.42606360962, 40172.598274016884, 48487.0, 50096.0, 50263.74868125636, 50311.0, 50397.74801125971, 7341.669624866787, 7482.588457634664, 7649.120351159688, 7682.884756728766, 7899.289063984269, 10373.792524149625, 11922.344271065174, 12209.206401583868, 12342.259464432163, 12505.249685018927, 10594.31136976094, 10683.679489615324, 10702.464876755976, 10878.12974962017, 10912.890871091187, 10448.164146868385, 10996.945015274872, 11016.724581885517, 11260.662180134608, 11497.482613282255, 10190.592376305161, 10209.540570674486, 10727.946360268148, 10986.285891417032, 11413.486393112164, 7544.0, 7600.695972161052, 7733.806654833449, 7792.805179870548, 7913.44605877583, 9810.950945245228, 10564.524596393334, 10626.52180651857, 10674.73313167177, 10835.079018283534], "value": 8438.150180939934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.8403949506312, 1386.2237147197568, 1396.9161850288976, 1679.3114822922605, 1711.4266720648582, 7484.139323977744, 7833.686652533892, 8009.519428834266, 8016.078151012635, 8020.639071241793, 6533.118029066075, 7499.100107987049, 7656.042994625672, 7672.96163519183, 7839.294463498299, 2205.4155648753135, 2228.0308065991267, 2233.0621139121527, 2233.486298151426, 2239.507308392151, 2199.9010044547954, 2243.7756224377595, 2271.5116250006245, 2271.806896413807, 2273.2611901132113, 1846.5199048247484, 1913.0434782608695, 1913.6746753052014, 1914.7606549181353, 2149.8387620928415, 2167.4689701023194, 2192.758796532396, 2195.319450970196, 2196.121551379445, 2197.7582465928735, 2162.935111946644, 2201.3836125884777, 2211.380813372258, 2249.977500224993, 2255.481239314967, 6561.442277406426, 7414.443916706215, 7590.430717696195, 7877.212278772135, 7940.2059794020715, 4610.331501932201, 4760.33355330254, 4766.713997160182, 4767.570918617306, 4768.451628062782, 2815.0850973433717, 2877.84171870547, 2900.3039270575123, 2931.6482022157265, 2945.882164713409, 922.0871337376017, 922.3082687984012, 940.1632547033146, 944.8677185194078, 952.4475804033644, 10261.589536418534, 10325.225608079425, 10331.690049298533, 10334.534945927377, 10335.276530642783, 4137.54487006429, 4236.894077648022, 4367.934480982788, 4377.562243775661, 4408.713433626868, 8733.868991965126, 8776.297896168291, 8801.779955501164, 8805.0, 8805.823883522422, 4604.7927843247135, 4604.930926036112, 4606.677532572688, 4607.170709272363, 4607.585317321457, 4148.066684995852, 4192.622663960197, 4209.1792100540715, 4209.5790420957655, 4301.548337424525, 3616.7829930203748, 3667.94498082529, 3702.278055779151, 3720.8697695580527, 3737.71967102463, 1195.9342236177094, 1224.6081253998634, 1224.9020078393708, 1232.4577186038114, 1247.7566874459574, 724.7282269149069, 738.903942487484, 853.4452605806151, 857.3784006595168, 864.9610767515477, 5090.643654944192, 5215.452377500384, 5250.448702886219, 5271.815486457956, 5299.655522391032, 407.06172272911226, 413.50173041484936, 414.6164797562243, 421.56999860142486, 424.0395504183028, 3549.2369140634887, 3562.2163124112653, 3601.423772196436, 3620.0768803954825, 3624.7462677612843, 9213.355065145375, 9603.807923841485, 9715.07706767856, 9724.805503889882, 9744.512774361254, 9644.083812037845, 9649.276304277208, 9649.517524123767, 9659.082387173208, 9671.9032809671, 7182.928170718226, 7284.235155308616, 7375.11498620169, 7375.4099672026105, 7384.815379615553, 5233.215017747216, 5253.212018197301, 5267.394249661184, 5291.23277124807, 5307.177387504943, 8872.423292485968, 8929.241014513838, 9042.0, 9092.454452732858, 9158.450492970444, 8907.777305567153, 9098.135677110664, 9125.817483650157, 9310.394824336396, 9310.48792316402, 6792.184937807495, 6837.179538455218, 6856.588604683735, 6860.348266914635, 6885.208201056742, 7219.711211551689, 7496.662650180646, 7498.10022797246, 7697.499662521918, 7706.614669266626, 5180.533751962191, 6401.64790936503, 6671.432928201158, 6771.119754431892, 6930.896036559355, 6550.246721626883, 6570.638614876037, 6642.43539299165, 7017.3684368407085, 7028.543144695578, 6428.453581445629, 6496.220453545605, 6499.057636642755, 6502.967485162544, 6507.642079685663, 4557.612602928788, 4586.518415566451, 4611.608013318905, 4691.859244222679, 4770.165221086366, 4793.856184314476, 4800.543948324904, 4814.9518504814505, 4841.672323603397, 4886.53577910098], "value": 4062.147187012862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.150271725582, 301.27092436304144, 308.3816947021222, 309.91012606344157, 311.9610048743907, 4790.880227994302, 4848.103100926327, 4879.194932836078, 4879.463259041502, 4912.870039890823, 4581.977090114553, 4665.463471700756, 4736.194846876031, 4820.228763397857, 4858.927116093261, 3808.4096964970336, 3826.4834247376666, 3848.9615103848955, 3849.2493963677093, 3850.711196660248, 3851.2297540491872, 3861.6524512793844, 3879.70902182336, 3882.0, 3891.805409729516, 3635.1457407509215, 3710.0353907983986, 3812.4178465936743, 3827.0432391902023, 3844.4233364995334, 3781.9054523636855, 3794.6015668354976, 3815.4467602197665, 3824.3116239076953, 3826.502554667903, 3406.1654894550747, 3412.5051867479324, 3420.9486857697157, 3421.863125474978, 3434.295969326282, 4519.305260527302, 4742.359781429497, 4772.785224664898, 4795.0409918016185, 4803.759812009385, 4231.365295205713, 4302.7203231790145, 4303.0, 4303.548127446605, 4323.027318853265, 5064.746762661852, 5072.6195535335, 5090.414602320743, 5100.668456550312, 5105.795768169269, 3575.8199794067896, 3636.4363523653874, 3653.3058718843336, 3661.340958627446, 3666.4866918631415, 5287.726277700587, 5343.706096164709, 5344.545713614348, 5351.170568561879, 5372.382176049726, 3710.424884142962, 3721.553413590332, 3722.088088418355, 3722.4602432647116, 3739.8317075731657, 3756.1736417988, 3780.905477363088, 3786.1291902861944, 3794.6015668354426, 3795.772253664789, 4054.1688953764406, 4317.0934103838545, 4321.459817522809, 4321.870343889688, 4323.546027667113, 5082.923756143661, 5096.337476128154, 5101.311322971425, 5125.56432703217, 5132.692038477703, 1232.2544860359533, 1269.0672355818467, 1271.5549557654747, 1293.1659079893416, 1313.8423389193358, 850.2093053460218, 869.9434536755091, 875.4965894610497, 897.241830653097, 913.6528119314618, 4438.644908407384, 4442.0, 4452.621527170227, 4453.755043472575, 4455.242608756519, 5227.3465816772905, 5248.897731476432, 5259.158534634516, 5264.684118952875, 5264.947350526522, 4354.9564504355185, 4556.931646025312, 4585.174668559691, 4586.3579098926175, 4587.655925805578, 2780.958285625717, 2818.788590855653, 2824.971750282471, 2830.2924268932766, 2837.730415610514, 4742.407199100113, 4942.838432968249, 4954.405471343462, 4977.676451030671, 4983.181138884281, 5359.330083739533, 5362.570994320445, 5378.1663842104535, 5386.946130538723, 5401.648892821954, 4874.512548745097, 4908.754562271872, 4924.704517728947, 4969.0807200668, 4970.975145124251, 5088.414832294334, 5224.197651810119, 5244.344456942882, 5247.265382846481, 5269.446708095595, 5105.821296254762, 5118.692878427306, 5135.071670172396, 5135.204043373283, 5141.588672906233, 4850.95149048505, 4903.8528844134735, 4929.756960582998, 4952.77712502931, 4970.7514624267915, 3625.0, 3693.9261214775015, 3713.1274150574054, 3725.7578257413184, 3726.9813650931574, 5196.506331898464, 5215.374155101412, 5227.4249832517635, 5236.0, 5271.8682032947945, 4980.825671101494, 4992.850214493571, 5042.14283571801, 5066.41736200327, 5067.41724701664, 4799.760011999316, 4987.576056035133, 5007.674501157413, 5016.372953380827, 5017.749112544431, 4731.29030645406, 4799.688020278671, 4905.1416002200185, 4922.72924989129, 4953.801847926043, 4988.351514303117, 5011.544343271844, 5020.0, 5032.572231360229, 5042.571381432619, 4878.317035615088, 4879.829205977774, 4890.902181956412, 4891.559759621651, 4908.361912951436], "value": 3836.645161913236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6417416682075, 721.722136977264, 726.963651817409, 750.2385079144673, 753.1150897695206, 11823.586174483895, 12607.810882836764, 12639.55761548346, 12641.0, 12641.747165056693, 12070.577529786458, 12262.693432664166, 12277.14060015797, 12281.342018827478, 12304.446299916503, 616.9629822210659, 752.5296689569019, 760.3726925286633, 784.4038530716668, 788.6056971514242, 773.5745340062971, 787.4723934963588, 787.8660627693306, 787.873940169573, 788.2984144111745, 843.1357858195338, 848.1264297773304, 848.6011574559947, 848.6138806842872, 848.9066202717727, 640.1358166475268, 787.0673252196166, 816.2857499687773, 835.2107258640588, 835.4277320035795, 607.3531688751509, 608.191105829246, 608.9360617135226, 608.939106089392, 609.0468416927495, 13498.190108593515, 13510.594682159453, 13522.459101635923, 13528.526501572496, 13534.796978045239, 12570.811437828439, 12707.872921270762, 13035.0, 13052.738945221043, 13197.604071877859, 11782.410879456078, 11788.17482776206, 11837.704057398549, 11844.230125041844, 12203.145779795417, 3275.4922986937063, 3349.2129349602824, 3371.342588195303, 3440.707539859115, 4190.706650534464, 53824.73087634576, 55098.0, 55176.172357414674, 61050.0, 61062.0, 10595.894041059644, 10817.675469735921, 11115.499802508906, 11344.773104538028, 11431.371274579811, 21142.78857211439, 21170.78829211719, 21761.891190544262, 21838.344849654535, 21843.235486757887, 7200.351968322771, 7271.418286537064, 7319.707211711579, 7336.669849856769, 7506.197915111, 3734.3651579231596, 3840.7503512271614, 3860.2665493556697, 3922.5685174630767, 3956.604339566078, 2926.0929111975356, 3030.7423868971387, 3033.6056312679652, 3033.7876348655823, 3034.863431145604, 516.8630312967067, 536.3858382152414, 542.4250294687644, 545.1522881918576, 549.6262541471838, 511.81063006687765, 513.5147285814944, 593.7981086430634, 602.3103546439303, 608.8295277322356, 7816.8827467588035, 7849.332806711379, 8052.463474005669, 8099.149589293157, 8158.755237342889, 502.3670175578797, 545.7598656591088, 588.3821986913723, 616.3559080760616, 632.8892443822405, 3468.6878180963836, 3700.648438398348, 3786.3752480840903, 3807.162424266657, 3903.2388684206876, 55277.447225528034, 79022.6048869752, 93180.53409732907, 98832.50583747035, 100110.4994475023, 84615.0, 87224.5638771802, 87461.0, 87508.0, 87853.0, 47071.764641176575, 59237.703811480664, 66573.0, 73680.26319736734, 75481.62259188779, 7094.290570942864, 7101.396381307647, 7208.603526806076, 7325.633718313957, 7369.668364923698, 36302.27395452129, 42722.359164613175, 43628.345574815765, 43705.56294437015, 44333.77833110814, 56817.71591142018, 57258.427415726976, 61194.71636985368, 65333.673331633036, 65996.67001664962, 10474.895251047697, 10538.525766340686, 10624.468776561296, 10755.139588833032, 11440.771184576428, 12855.614331570068, 13065.281409522568, 13250.9399248058, 13372.063955523408, 13493.662658433617, 12020.459079341275, 12241.0, 12532.436040378387, 12812.935935320264, 13238.073334866853, 12153.1492795507, 12373.876261237632, 12433.254004759743, 12489.687757806127, 12720.618381448572, 10966.342019478856, 11430.828537571777, 11615.76768464643, 11805.055595552163, 11910.583129590423, 10401.94799026, 10650.467476625983, 11052.502637381176, 11336.6032188873, 11370.658880233606, 9751.3661611995, 9771.657991970247, 10230.744231394274, 10238.385696858213, 10322.48387580633], "value": 6586.016651876799, "unit": "score"}], "name": "dromaeo_css", "value": 6460.06884292637, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 113.0, 115.0, 115.0, 114.0, 112.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 127.0, 169.0, 122.0, 144.0, 145.0, 129.0, 181.0, 124.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 160.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 109.0, 77.0, 77.0, 75.0, 76.0, 103.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 116.0, 84.0, 85.0, 85.0, 125.0, 84.0, 84.0, 123.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 99.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 62.0, 63.0, 63.0, 64.0, 63.0, 67.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 87.0, 82.0, 78.0, 78.0, 86.0, 79.0, 82.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 136.0, 137.0, 135.0, 129.0, 130.0, 130.0, 166.0, 133.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 164.0, 169.0, 160.0, 161.0, 162.0, 162.0, 160.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 65.0, 65.0, 66.0, 64.0, 76.0, 64.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1531.1000000000001, "alertThreshold": 2.0}]} 12:19:20 INFO - Return code: 0 12:19:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:20 INFO - # TBPL SUCCESS # 12:19:20 INFO - Running post-action listener: _resource_record_post_action 12:19:20 INFO - [mozharness: 2016-07-19 19:19:20.587397Z] Finished run-tests step (success) 12:19:20 INFO - Running post-run listener: _resource_record_post_run 12:19:20 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285093888; Read time: 8; Write time: 225904 12:19:20 INFO - TinderboxPrint: CPU usage
13.0% 12:19:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:19:20 INFO - TinderboxPrint: I/O write bytes / time
285,093,888 / 225,904 12:19:20 INFO - TinderboxPrint: CPU idle
8,329.9 (87.0%) 12:19:20 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 12:19:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:19:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1376256; Read time: 0; Write time: 44 12:19:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 283676672; Read time: 0; Write time: 225832 12:19:21 INFO - Running post-run listener: _upload_blobber_files 12:19:21 INFO - Blob upload gear active. 12:19:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:21 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 12:19:21 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'] 12:19:21 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 12:19:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:19:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:43 INFO - (blobuploader) - INFO - Done attempting. 12:19:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:19:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:45 INFO - (blobuploader) - INFO - Done attempting. 12:19:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:19:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:19:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:47 INFO - (blobuploader) - INFO - Done attempting. 12:19:47 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:47 INFO - Return code: 0 12:19:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec3de93818dbe650334e224b8eda607e4f91b217b7f2d4f3cb6ef1bb8bcace9d79e62c1650161db0ccc328551660ddc0ef14a08fcdf09595fc2ef853b74c8451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2258338f741d204045b5034638df14180e029caaa20b37039597d75d85a26c6b9c68f0164a5717f99c704c072b3454d08aa06aef5039dafda1ad7df4add93e7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a237bf7516cc34a545b48e6a0346c8d7d4816342bcc1a47730a1a7a08b62419a9de58714a5c1b761f603c8f0ce3626e29b23a193d9abe49d41b4d076efdf5cb8"} 12:19:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:47 INFO - Contents: 12:19:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec3de93818dbe650334e224b8eda607e4f91b217b7f2d4f3cb6ef1bb8bcace9d79e62c1650161db0ccc328551660ddc0ef14a08fcdf09595fc2ef853b74c8451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2258338f741d204045b5034638df14180e029caaa20b37039597d75d85a26c6b9c68f0164a5717f99c704c072b3454d08aa06aef5039dafda1ad7df4add93e7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a237bf7516cc34a545b48e6a0346c8d7d4816342bcc1a47730a1a7a08b62419a9de58714a5c1b761f603c8f0ce3626e29b23a193d9abe49d41b4d076efdf5cb8"} 12:19:47 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:47 INFO - Copying logs to upload dir... 12:19:47 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.433732 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-07-19 12:19:47.385288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:19:47.388326) ========= 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-1468954713.194361-1095684040 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/ec3de93818dbe650334e224b8eda607e4f91b217b7f2d4f3cb6ef1bb8bcace9d79e62c1650161db0ccc328551660ddc0ef14a08fcdf09595fc2ef853b74c8451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2258338f741d204045b5034638df14180e029caaa20b37039597d75d85a26c6b9c68f0164a5717f99c704c072b3454d08aa06aef5039dafda1ad7df4add93e7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a237bf7516cc34a545b48e6a0346c8d7d4816342bcc1a47730a1a7a08b62419a9de58714a5c1b761f603c8f0ce3626e29b23a193d9abe49d41b4d076efdf5cb8"} build_url:https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/XR7XGWsYQcuJRQEy80TkIg/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/ec3de93818dbe650334e224b8eda607e4f91b217b7f2d4f3cb6ef1bb8bcace9d79e62c1650161db0ccc328551660ddc0ef14a08fcdf09595fc2ef853b74c8451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2258338f741d204045b5034638df14180e029caaa20b37039597d75d85a26c6b9c68f0164a5717f99c704c072b3454d08aa06aef5039dafda1ad7df4add93e7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a237bf7516cc34a545b48e6a0346c8d7d4816342bcc1a47730a1a7a08b62419a9de58714a5c1b761f603c8f0ce3626e29b23a193d9abe49d41b4d076efdf5cb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:19:47.414728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:19:47.415027) ========= 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-1468954713.194361-1095684040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:19:47.499852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:19:47.500207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:19:47.500486) ========= ========= Total master_lag: 0.18 =========