builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1467815717.98 results: success (0) buildid: 20160706062223 builduid: c3f4f532c9514de5b175b9457cc1aaa3 revision: 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:17.980528) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:17.981164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:17.982105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.008341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.008605) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 07:35:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-07-06 07:35:18 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.098873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.099157) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.149807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.150132) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 --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 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 07:35:18,714 truncating revision to first 12 chars 2016-07-06 07:35:18,714 Setting DEBUG logging. 2016-07-06 07:35:18,714 attempt 1/10 2016-07-06 07:35:18,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6984d7cf65bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 07:35:19,023 unpacking tar archive at: autoland-6984d7cf65bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.819009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.819713) ========= script_repo_revision: 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.820716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.821453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 07:35:18.833416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-06 07:35:18.833687) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:35:19 INFO - MultiFileLogger online at 20160706 07:35:19 in /builds/slave/test 07:35:19 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 07:35:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:19 INFO - {'append_to_log': False, 07:35:19 INFO - 'base_work_dir': '/builds/slave/test', 07:35:19 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:35:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:19 INFO - 'branch': 'Autoland-Non-PGO', 07:35:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:19 INFO - 'config_files': ('talos/linux_config.py',), 07:35:19 INFO - 'default_actions': ('clobber', 07:35:19 INFO - 'read-buildbot-config', 07:35:19 INFO - 'download-and-extract', 07:35:19 INFO - 'populate-webroot', 07:35:19 INFO - 'create-virtualenv', 07:35:19 INFO - 'install', 07:35:19 INFO - 'run-tests'), 07:35:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:19 INFO - 'download_minidump_stackwalk': True, 07:35:19 INFO - 'download_symbols': 'ondemand', 07:35:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:19 INFO - 'installer_path': 'installer.exe', 07:35:19 INFO - 'log_level': 'info', 07:35:19 INFO - 'log_name': 'talos', 07:35:19 INFO - 'log_to_console': True, 07:35:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:35:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:35:19 INFO - 'opt_config_files': (), 07:35:19 INFO - 'pip_index': False, 07:35:19 INFO - 'sps_profile': False, 07:35:19 INFO - 'sps_profile_interval': 0, 07:35:19 INFO - 'suite': 'dromaeojs', 07:35:19 INFO - 'system_bits': '32', 07:35:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:19 INFO - 'title': 'talos-linux64-ix-069', 07:35:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:19 INFO - 'use_talos_json': True, 07:35:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:19 INFO - 'work_dir': 'build'} 07:35:19 INFO - ##### 07:35:19 INFO - ##### Running clobber step. 07:35:19 INFO - ##### 07:35:19 INFO - Running pre-action listener: _resource_record_pre_action 07:35:19 INFO - Running main action method: clobber 07:35:19 INFO - rmtree: /builds/slave/test/build 07:35:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:19 INFO - Running post-action listener: _resource_record_post_action 07:35:19 INFO - ##### 07:35:19 INFO - ##### Finished clobber step (success) 07:35:19 INFO - ##### 07:35:19 INFO - ##### 07:35:19 INFO - ##### Running read-buildbot-config step. 07:35:19 INFO - ##### 07:35:19 INFO - Running pre-action listener: _resource_record_pre_action 07:35:19 INFO - Running main action method: read_buildbot_config 07:35:19 INFO - Using buildbot properties: 07:35:19 INFO - { 07:35:19 INFO - "project": "", 07:35:19 INFO - "product": "firefox", 07:35:19 INFO - "script_repo_revision": "production", 07:35:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:35:19 INFO - "repository": "", 07:35:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:35:19 INFO - "buildid": "20160706062223", 07:35:19 INFO - "pgo_build": "False", 07:35:19 INFO - "basedir": "/builds/slave/test", 07:35:19 INFO - "buildnumber": 65, 07:35:19 INFO - "slavename": "talos-linux64-ix-069", 07:35:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:35:19 INFO - "platform": "ubuntu64_hw", 07:35:19 INFO - "scheduler": "tests-autoland-linux64-talos", 07:35:19 INFO - "branch": "autoland", 07:35:19 INFO - "repo_path": "integration/autoland", 07:35:19 INFO - "revision": "6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3", 07:35:19 INFO - "stage_platform": "linux64", 07:35:19 INFO - "builduid": "c3f4f532c9514de5b175b9457cc1aaa3", 07:35:19 INFO - "slavebuilddir": "test" 07:35:19 INFO - } 07:35:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:35:19 INFO - Running post-action listener: _resource_record_post_action 07:35:19 INFO - ##### 07:35:19 INFO - ##### Finished read-buildbot-config step (success) 07:35:19 INFO - ##### 07:35:19 INFO - ##### 07:35:19 INFO - ##### Running download-and-extract step. 07:35:19 INFO - ##### 07:35:19 INFO - Running pre-action listener: _resource_record_pre_action 07:35:19 INFO - Running main action method: download_and_extract 07:35:19 INFO - mkdir: /builds/slave/test/build/tests 07:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:19 INFO - https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:35:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:25 INFO - Downloaded 1361 bytes. 07:35:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:25 INFO - Using the following test package requirements: 07:35:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:35:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'jsshell-linux-x86_64.zip'], 07:35:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:35:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:35:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:25 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')]} 07:35:25 INFO - https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:26 INFO - Downloaded 22732632 bytes. 07:35:26 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'] 07:35:26 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 07:35:27 INFO - Return code: 0 07:35:27 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 07:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:35:27 INFO - https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:31 INFO - Downloaded 22732632 bytes. 07:35:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:35:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:35:33 INFO - Return code: 0 07:35:33 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')]} 07:35:33 INFO - https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:34 INFO - Downloaded 14403333 bytes. 07:35:34 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'] 07:35:34 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 07:35:34 INFO - Return code: 0 07:35:34 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')]} 07:35:34 INFO - https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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 07:35:35 INFO - Downloaded 56488942 bytes. 07:35:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:35 INFO - mkdir: /builds/slave/test/properties 07:35:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:35 INFO - Contents: 07:35:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:36 INFO - Running post-action listener: _resource_record_post_action 07:35:36 INFO - Running post-action listener: set_extra_try_arguments 07:35:36 INFO - ##### 07:35:36 INFO - ##### Finished download-and-extract step (success) 07:35:36 INFO - ##### 07:35:36 INFO - ##### 07:35:36 INFO - ##### Running populate-webroot step. 07:35:36 INFO - ##### 07:35:36 INFO - Running pre-action listener: _resource_record_pre_action 07:35:36 INFO - Running main action method: populate_webroot 07:35:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:36 INFO - '--tppagecycles', 07:35:36 INFO - '7'], 07:35:36 INFO - 'tests': ['tsvgm']}}, 07:35:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['damp', 'tps']}, 07:35:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'tests': ['damp', 'tps']}, 07:35:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['dromaeo_dom']}, 07:35:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['basic_compositor_video']}, 07:35:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['a11yr', 07:35:36 INFO - 'ts_paint', 07:35:36 INFO - 'tpaint', 07:35:36 INFO - 'sessionrestore', 07:35:36 INFO - 'sessionrestore_no_auto_restore', 07:35:36 INFO - 'tabpaint']}, 07:35:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['tsvgx', 07:35:36 INFO - 'tsvgr_opacity', 07:35:36 INFO - 'tart', 07:35:36 INFO - 'tscrollx', 07:35:36 INFO - 'cart']}, 07:35:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:36 INFO - 'tsvgr_opacity', 07:35:36 INFO - 'tart', 07:35:36 INFO - 'tscrollx', 07:35:36 INFO - 'cart']}, 07:35:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'talos_options': ['--disable-e10s'], 07:35:36 INFO - 'tests': ['tp5o']}, 07:35:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'tests': ['tp5o']}, 07:35:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'talos_options': ['--disable-e10s', 07:35:36 INFO - '--xperf_path', 07:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:36 INFO - 'tests': ['tp5n']}, 07:35:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:36 INFO - 'talos_options': ['--xperf_path', 07:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:36 INFO - 'tests': ['tp5n']}}, 07:35:36 INFO - 'talos.zip': {'path': '', 07:35:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:36 INFO - Running post-action listener: _resource_record_post_action 07:35:36 INFO - ##### 07:35:36 INFO - ##### Finished populate-webroot step (success) 07:35:36 INFO - ##### 07:35:36 INFO - ##### 07:35:36 INFO - ##### Running create-virtualenv step. 07:35:36 INFO - ##### 07:35:36 INFO - Running pre-action listener: _resource_record_pre_action 07:35:36 INFO - Running main action method: create_virtualenv 07:35:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:36 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 07:35:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:36 INFO - Using real prefix '/usr' 07:35:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:39 INFO - Installing pip.................done. 07:35:39 INFO - Return code: 0 07:35:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:39 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:39 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 07:35:39 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 07:35:39 INFO - Using env: {'DISPLAY': ':0', 07:35:39 INFO - 'HOME': '/home/cltbld', 07:35:39 INFO - 'LANG': 'en_US.UTF-8', 07:35:39 INFO - 'LANGUAGE': 'en_US:en', 07:35:39 INFO - 'LOGNAME': 'cltbld', 07:35:39 INFO - 'MAIL': '/var/mail/cltbld', 07:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:39 INFO - 'MOZ_NO_REMOTE': '1', 07:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:39 INFO - 'NO_EM_RESTART': '1', 07:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:39 INFO - 'PWD': '/builds/slave/test', 07:35:39 INFO - 'SHELL': '/bin/bash', 07:35:39 INFO - 'SHLVL': '1', 07:35:39 INFO - 'TERM': 'linux', 07:35:39 INFO - 'TMOUT': '86400', 07:35:39 INFO - 'USER': 'cltbld', 07:35:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:39 INFO - '_': '/tools/buildbot/bin/python'} 07:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:39 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 07:35:39 INFO - Cleaning up... 07:35:39 INFO - Return code: 0 07:35:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:39 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:39 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 07:35:39 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 07:35:39 INFO - Using env: {'DISPLAY': ':0', 07:35:39 INFO - 'HOME': '/home/cltbld', 07:35:39 INFO - 'LANG': 'en_US.UTF-8', 07:35:39 INFO - 'LANGUAGE': 'en_US:en', 07:35:39 INFO - 'LOGNAME': 'cltbld', 07:35:39 INFO - 'MAIL': '/var/mail/cltbld', 07:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:39 INFO - 'MOZ_NO_REMOTE': '1', 07:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:39 INFO - 'NO_EM_RESTART': '1', 07:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:39 INFO - 'PWD': '/builds/slave/test', 07:35:39 INFO - 'SHELL': '/bin/bash', 07:35:39 INFO - 'SHLVL': '1', 07:35:39 INFO - 'TERM': 'linux', 07:35:39 INFO - 'TMOUT': '86400', 07:35:39 INFO - 'USER': 'cltbld', 07:35:39 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:39 INFO - '_': '/tools/buildbot/bin/python'} 07:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:39 INFO - Downloading/unpacking psutil>=3.1.1 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:41 INFO - Installing collected packages: psutil 07:35:41 INFO - Running setup.py install for psutil 07:35:41 INFO - building 'psutil._psutil_linux' extension 07:35:41 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 07:35:42 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 07:35:42 INFO - building 'psutil._psutil_posix' extension 07:35:42 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 07:35:42 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 07:35:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:42 INFO - Successfully installed psutil 07:35:42 INFO - Cleaning up... 07:35:42 INFO - Return code: 0 07:35:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:35:42 INFO - Using env: {'DISPLAY': ':0', 07:35:42 INFO - 'HOME': '/home/cltbld', 07:35:42 INFO - 'LANG': 'en_US.UTF-8', 07:35:42 INFO - 'LANGUAGE': 'en_US:en', 07:35:42 INFO - 'LOGNAME': 'cltbld', 07:35:42 INFO - 'MAIL': '/var/mail/cltbld', 07:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:42 INFO - 'MOZ_NO_REMOTE': '1', 07:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:42 INFO - 'NO_EM_RESTART': '1', 07:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:42 INFO - 'PWD': '/builds/slave/test', 07:35:42 INFO - 'SHELL': '/bin/bash', 07:35:42 INFO - 'SHLVL': '1', 07:35:42 INFO - 'TERM': 'linux', 07:35:42 INFO - 'TMOUT': '86400', 07:35:42 INFO - 'USER': 'cltbld', 07:35:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:42 INFO - '_': '/tools/buildbot/bin/python'} 07:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:44 INFO - Installing collected packages: mozsystemmonitor 07:35:44 INFO - Running setup.py install for mozsystemmonitor 07:35:44 INFO - Successfully installed mozsystemmonitor 07:35:44 INFO - Cleaning up... 07:35:44 INFO - Return code: 0 07:35:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:44 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')]} 07:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:44 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')]} 07:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:44 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:44 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 07:35:44 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 07:35:44 INFO - Using env: {'DISPLAY': ':0', 07:35:44 INFO - 'HOME': '/home/cltbld', 07:35:44 INFO - 'LANG': 'en_US.UTF-8', 07:35:44 INFO - 'LANGUAGE': 'en_US:en', 07:35:44 INFO - 'LOGNAME': 'cltbld', 07:35:44 INFO - 'MAIL': '/var/mail/cltbld', 07:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:44 INFO - 'MOZ_NO_REMOTE': '1', 07:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:44 INFO - 'NO_EM_RESTART': '1', 07:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:44 INFO - 'PWD': '/builds/slave/test', 07:35:44 INFO - 'SHELL': '/bin/bash', 07:35:44 INFO - 'SHLVL': '1', 07:35:44 INFO - 'TERM': 'linux', 07:35:44 INFO - 'TMOUT': '86400', 07:35:44 INFO - 'USER': 'cltbld', 07:35:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:44 INFO - '_': '/tools/buildbot/bin/python'} 07:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:47 INFO - warning: no files found matching '*.txt' 07:35:47 INFO - no previously-included directories found matching 'build' 07:35:47 INFO - no previously-included directories found matching 'dist' 07:35:47 INFO - no previously-included directories found matching '.git*' 07:35:47 INFO - Installing collected packages: jsonschema, functools32 07:35:47 INFO - Running setup.py install for functools32 07:35:47 INFO - warning: no files found matching '*.txt' 07:35:47 INFO - no previously-included directories found matching 'build' 07:35:47 INFO - no previously-included directories found matching 'dist' 07:35:47 INFO - no previously-included directories found matching '.git*' 07:35:47 INFO - Successfully installed jsonschema functools32 07:35:47 INFO - Cleaning up... 07:35:47 INFO - Return code: 0 07:35:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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', '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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:35: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 blobuploader==1.2.4 07:35:47 INFO - Using env: {'DISPLAY': ':0', 07:35:47 INFO - 'HOME': '/home/cltbld', 07:35:47 INFO - 'LANG': 'en_US.UTF-8', 07:35:47 INFO - 'LANGUAGE': 'en_US:en', 07:35:47 INFO - 'LOGNAME': 'cltbld', 07:35:47 INFO - 'MAIL': '/var/mail/cltbld', 07:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:47 INFO - 'MOZ_NO_REMOTE': '1', 07:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:47 INFO - 'NO_EM_RESTART': '1', 07:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:47 INFO - 'PWD': '/builds/slave/test', 07:35:47 INFO - 'SHELL': '/bin/bash', 07:35:47 INFO - 'SHLVL': '1', 07:35:47 INFO - 'TERM': 'linux', 07:35:47 INFO - 'TMOUT': '86400', 07:35:47 INFO - 'USER': 'cltbld', 07:35:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:47 INFO - '_': '/tools/buildbot/bin/python'} 07:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:50 INFO - Downloading docopt-0.6.1.tar.gz 07:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:50 INFO - Running setup.py install for blobuploader 07:35:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:50 INFO - Running setup.py install for requests 07:35:50 INFO - Running setup.py install for docopt 07:35:50 INFO - Successfully installed blobuploader requests docopt 07:35:50 INFO - Cleaning up... 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:50 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 07:35:50 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 07:35:50 INFO - Using env: {'DISPLAY': ':0', 07:35:50 INFO - 'HOME': '/home/cltbld', 07:35:50 INFO - 'LANG': 'en_US.UTF-8', 07:35:50 INFO - 'LANGUAGE': 'en_US:en', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MAIL': '/var/mail/cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SHLVL': '1', 07:35:50 INFO - 'TERM': 'linux', 07:35:50 INFO - 'TMOUT': '86400', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - '_': '/tools/buildbot/bin/python'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:51 INFO - Running setup.py (path:/tmp/pip-xexIqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:51 INFO - Running setup.py (path:/tmp/pip-P9Guj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:51 INFO - Running setup.py (path:/tmp/pip-Img97k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:51 INFO - Running setup.py (path:/tmp/pip-L94Ynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:51 INFO - Running setup.py (path:/tmp/pip-LWYLcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:51 INFO - Running setup.py (path:/tmp/pip-1N8VJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:51 INFO - Running setup.py (path:/tmp/pip-S07JKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:51 INFO - Running setup.py (path:/tmp/pip-PdRdli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:51 INFO - Running setup.py (path:/tmp/pip-HSPo78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:51 INFO - Running setup.py (path:/tmp/pip-QaX6ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:51 INFO - Running setup.py (path:/tmp/pip-rBibf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:51 INFO - Running setup.py (path:/tmp/pip-POzjeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:51 INFO - Running setup.py (path:/tmp/pip-ZI96jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:51 INFO - Running setup.py (path:/tmp/pip-RjdK8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:52 INFO - Running setup.py (path:/tmp/pip-yMI2vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:52 INFO - Running setup.py (path:/tmp/pip-dW_K0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:52 INFO - Running setup.py (path:/tmp/pip-UkGV3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:52 INFO - Running setup.py install for manifestparser 07:35:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:52 INFO - Running setup.py install for mozcrash 07:35:52 INFO - Running setup.py install for mozdebug 07:35:52 INFO - Running setup.py install for mozdevice 07:35:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:52 INFO - Running setup.py install for mozfile 07:35:52 INFO - Running setup.py install for mozhttpd 07:35:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:52 INFO - Running setup.py install for mozinfo 07:35:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:52 INFO - Running setup.py install for mozInstall 07:35:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for mozleak 07:35:53 INFO - Running setup.py install for mozlog 07:35:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for moznetwork 07:35:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for mozprocess 07:35:53 INFO - Running setup.py install for mozprofile 07:35:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for mozrunner 07:35:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for mozscreenshot 07:35:53 INFO - Running setup.py install for moztest 07:35:53 INFO - Running setup.py install for mozversion 07:35:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:54 INFO - Cleaning up... 07:35:54 INFO - Return code: 0 07:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:54 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:54 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 07:35:54 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 07:35:54 INFO - Using env: {'DISPLAY': ':0', 07:35:54 INFO - 'HOME': '/home/cltbld', 07:35:54 INFO - 'LANG': 'en_US.UTF-8', 07:35:54 INFO - 'LANGUAGE': 'en_US:en', 07:35:54 INFO - 'LOGNAME': 'cltbld', 07:35:54 INFO - 'MAIL': '/var/mail/cltbld', 07:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:54 INFO - 'MOZ_NO_REMOTE': '1', 07:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:54 INFO - 'NO_EM_RESTART': '1', 07:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:54 INFO - 'PWD': '/builds/slave/test', 07:35:54 INFO - 'SHELL': '/bin/bash', 07:35:54 INFO - 'SHLVL': '1', 07:35:54 INFO - 'TERM': 'linux', 07:35:54 INFO - 'TMOUT': '86400', 07:35:54 INFO - 'USER': 'cltbld', 07:35:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:54 INFO - '_': '/tools/buildbot/bin/python'} 07:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:54 INFO - Running setup.py (path:/tmp/pip-iRMCAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:54 INFO - Running setup.py (path:/tmp/pip-St7HZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:54 INFO - Running setup.py (path:/tmp/pip-iCfa74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:54 INFO - Running setup.py (path:/tmp/pip-IDRMO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:54 INFO - Running setup.py (path:/tmp/pip-8k2Uby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:54 INFO - Running setup.py (path:/tmp/pip-iHhgmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:54 INFO - Running setup.py (path:/tmp/pip-ds1A9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:54 INFO - Running setup.py (path:/tmp/pip-kNhUKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:54 INFO - Running setup.py (path:/tmp/pip-gBIEkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:54 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)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:54 INFO - Running setup.py (path:/tmp/pip-netcHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:54 INFO - Running setup.py (path:/tmp/pip-CdvqR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:55 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:55 INFO - Running setup.py (path:/tmp/pip-lWVIpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:55 INFO - Running setup.py (path:/tmp/pip-4zwrpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:55 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:55 INFO - Running setup.py (path:/tmp/pip-RFEnzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:55 INFO - Running setup.py (path:/tmp/pip-D7b0JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:55 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:55 INFO - Running setup.py (path:/tmp/pip-KABE2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:55 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)) 07:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:55 INFO - Running setup.py (path:/tmp/pip-9_nzQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:55 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)) 07:35:55 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)) 07:35:55 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)) 07:35:55 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)) 07:35:55 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)) 07:35:55 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)) 07:35:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:57 INFO - Downloading blessings-1.6.tar.gz 07:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:58 INFO - Installing collected packages: blessings 07:35:58 INFO - Running setup.py install for blessings 07:35:58 INFO - Successfully installed blessings 07:35:58 INFO - Cleaning up... 07:35:58 INFO - Return code: 0 07:35:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:58 INFO - Reading from file tmpfile_stdout 07:35:58 INFO - Current package versions: 07:35:58 INFO - argparse == 1.2.1 07:35:58 INFO - blessings == 1.6 07:35:58 INFO - blobuploader == 1.2.4 07:35:58 INFO - docopt == 0.6.1 07:35:58 INFO - functools32 == 3.2.3-2 07:35:58 INFO - jsonschema == 2.5.1 07:35:58 INFO - manifestparser == 1.1 07:35:58 INFO - mozInstall == 1.12 07:35:58 INFO - mozcrash == 0.17 07:35:58 INFO - mozdebug == 0.1 07:35:58 INFO - mozdevice == 0.48 07:35:58 INFO - mozfile == 1.2 07:35:58 INFO - mozhttpd == 0.7 07:35:58 INFO - mozinfo == 0.9 07:35:58 INFO - mozleak == 0.1 07:35:58 INFO - mozlog == 3.2 07:35:58 INFO - moznetwork == 0.27 07:35:58 INFO - mozprocess == 0.22 07:35:58 INFO - mozprofile == 0.28 07:35:58 INFO - mozrunner == 6.11 07:35:58 INFO - mozscreenshot == 0.1 07:35:58 INFO - mozsystemmonitor == 0.3 07:35:58 INFO - moztest == 0.7 07:35:58 INFO - mozversion == 1.4 07:35:58 INFO - psutil == 3.1.1 07:35:58 INFO - requests == 1.2.3 07:35:58 INFO - wsgiref == 0.1.2 07:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:58 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')]} 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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')]} 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:58 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 07:35:58 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 07:35:58 INFO - Using env: {'DISPLAY': ':0', 07:35:58 INFO - 'HOME': '/home/cltbld', 07:35:58 INFO - 'LANG': 'en_US.UTF-8', 07:35:58 INFO - 'LANGUAGE': 'en_US:en', 07:35:58 INFO - 'LOGNAME': 'cltbld', 07:35:58 INFO - 'MAIL': '/var/mail/cltbld', 07:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:58 INFO - 'MOZ_NO_REMOTE': '1', 07:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:58 INFO - 'NO_EM_RESTART': '1', 07:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:58 INFO - 'PWD': '/builds/slave/test', 07:35:58 INFO - 'SHELL': '/bin/bash', 07:35:58 INFO - 'SHLVL': '1', 07:35:58 INFO - 'TERM': 'linux', 07:35:58 INFO - 'TMOUT': '86400', 07:35:58 INFO - 'USER': 'cltbld', 07:35:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:58 INFO - '_': '/tools/buildbot/bin/python'} 07:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 INFO - Cleaning up... 07:35:58 INFO - Return code: 0 07:35:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:58 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')]} 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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')]} 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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 0x1094030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1355180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', '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 07:35:58 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 07:35:58 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 07:35:58 INFO - Using env: {'DISPLAY': ':0', 07:35:58 INFO - 'HOME': '/home/cltbld', 07:35:58 INFO - 'LANG': 'en_US.UTF-8', 07:35:58 INFO - 'LANGUAGE': 'en_US:en', 07:35:58 INFO - 'LOGNAME': 'cltbld', 07:35:58 INFO - 'MAIL': '/var/mail/cltbld', 07:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:58 INFO - 'MOZ_NO_REMOTE': '1', 07:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:58 INFO - 'NO_EM_RESTART': '1', 07:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:58 INFO - 'PWD': '/builds/slave/test', 07:35:58 INFO - 'SHELL': '/bin/bash', 07:35:58 INFO - 'SHLVL': '1', 07:35:58 INFO - 'TERM': 'linux', 07:35:58 INFO - 'TMOUT': '86400', 07:35:58 INFO - 'USER': 'cltbld', 07:35:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:58 INFO - '_': '/tools/buildbot/bin/python'} 07:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:58 INFO - Cleaning up... 07:35:58 INFO - Return code: 0 07:35:58 INFO - Running post-action listener: _resource_record_post_action 07:35:58 INFO - Running post-action listener: _start_resource_monitoring 07:35:58 INFO - Starting resource monitoring. 07:35:58 INFO - ##### 07:35:58 INFO - ##### Finished create-virtualenv step (success) 07:35:58 INFO - ##### 07:35:58 INFO - ##### 07:35:58 INFO - ##### Running install step. 07:35:58 INFO - ##### 07:35:58 INFO - Running pre-action listener: _resource_record_pre_action 07:35:58 INFO - Running main action method: install 07:35:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:59 INFO - Reading from file tmpfile_stdout 07:35:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:59 INFO - Reading from file tmpfile_stdout 07:35:59 INFO - Output received: 07:35:59 INFO - Usage: mozinstall [options] installer 07:35:59 INFO - Options: 07:35:59 INFO - -h, --help show this help message and exit 07:35:59 INFO - -d DEST, --destination=DEST 07:35:59 INFO - Directory to install application into. [default: 07:35:59 INFO - "/builds/slave/test"] 07:35:59 INFO - --app=APP Application being installed. [default: firefox] 07:35:59 INFO - mkdir: /builds/slave/test/build/application 07:35:59 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'] 07:35:59 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 07:36:15 INFO - Reading from file tmpfile_stdout 07:36:15 INFO - Output received: 07:36:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:15 INFO - Running post-action listener: _resource_record_post_action 07:36:15 INFO - ##### 07:36:15 INFO - ##### Finished install step (success) 07:36:15 INFO - ##### 07:36:15 INFO - ##### 07:36:15 INFO - ##### Running run-tests step. 07:36:15 INFO - ##### 07:36:15 INFO - Running pre-action listener: _resource_record_pre_action 07:36:15 INFO - Running main action method: run_tests 07:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:15 INFO - Python 2.7.3 07:36:15 INFO - Return code: 0 07:36:15 INFO - grabbing minidump binary from tooltool 07:36: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')]} 07:36:15 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 0x13533b0>, '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 0x13542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1354740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:15 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 07:36:15 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 07:36:15 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 07:36:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:15 INFO - Return code: 0 07:36:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:15 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/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:36:15 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/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 07:36:15 INFO - Using env: {'DISPLAY': ':0', 07:36:15 INFO - 'HOME': '/home/cltbld', 07:36:15 INFO - 'LANG': 'en_US.UTF-8', 07:36:15 INFO - 'LANGUAGE': 'en_US:en', 07:36:15 INFO - 'LOGNAME': 'cltbld', 07:36:15 INFO - 'MAIL': '/var/mail/cltbld', 07:36:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:15 INFO - 'MOZ_NO_REMOTE': '1', 07:36:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:15 INFO - 'NO_EM_RESTART': '1', 07:36:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:15 INFO - 'PWD': '/builds/slave/test', 07:36:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:15 INFO - 'SHELL': '/bin/bash', 07:36:15 INFO - 'SHLVL': '1', 07:36:15 INFO - 'TERM': 'linux', 07:36:15 INFO - 'TMOUT': '86400', 07:36:15 INFO - 'USER': 'cltbld', 07:36:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156', 07:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:15 INFO - '_': '/tools/buildbot/bin/python'} 07:36:15 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/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:36:15 INFO - mozversion application_buildid: 20160706062223 07:36:15 INFO - mozversion application_changeset: 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 07:36:15 INFO - mozversion application_display_name: Nightly 07:36:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:15 INFO - mozversion application_name: Firefox 07:36:15 INFO - mozversion application_remotingname: firefox 07:36:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:36:15 INFO - mozversion application_vendor: Mozilla 07:36:15 INFO - mozversion application_version: 50.0a1 07:36:15 INFO - mozversion platform_buildid: 20160706062223 07:36:15 INFO - mozversion platform_changeset: 6984d7cf65bbcf19443ef4c8e09e5c7f4e8ae5c3 07:36:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:36:15 INFO - mozversion platform_version: 50.0a1 07:36:15 INFO - using testdate: 1467815775 07:36:15 INFO - actual date: 1467815775 07:36:15 INFO - starting webserver on 'localhost:37780' 07:36:15 INFO - SUITE-START | Running 2 tests 07:36:15 INFO - TEST-START | dromaeo_css 07:36:15 INFO - operating with platform_type : linux_ 07:36:15 INFO - Initialising browser for dromaeo_css test... 07:36:15 INFO - TEST-INFO | started process 10293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV_IUgY/profile http://localhost:37780/getInfo.html) 07:36:20 INFO - PROCESS | 10293 | __metrics Screen width/height:1600/1200 07:36:20 INFO - PROCESS | 10293 | colorDepth:24 07:36:20 INFO - PROCESS | 10293 | Browser inner width/height: 1024/697 07:36:20 INFO - PROCESS | 10293 | __metrics 07:36:21 INFO - PROCESS | 10293 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:22 INFO - TEST-INFO | 10293: exit 0 07:36:22 INFO - Browser initialized. 07:36:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:22 INFO - TEST-INFO | started process 10376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV_IUgY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:34 INFO - PROCESS | 10376 | RSS: Main: 158654464 07:36:34 INFO - PROCESS | 10376 | 07:37:25 INFO - PROCESS | 10376 | 1467815845483 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] 07:39:38 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37780/tests/dromaeo/cssquery-ext.html) 07:39:39 INFO - PROCESS | 10376 | RSS: Main: 275238912 07:39:39 INFO - PROCESS | 10376 | 07:42:42 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-ext.html (next: http://localhost:37780/tests/dromaeo/cssquery-jquery.html) 07:42:42 INFO - PROCESS | 10376 | RSS: Main: 239894528 07:42:42 INFO - PROCESS | 10376 | 07:45:45 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37780/tests/dromaeo/cssquery-mootools.html) 07:45:45 INFO - PROCESS | 10376 | RSS: Main: 235397120 07:45:45 INFO - PROCESS | 10376 | 07:48:47 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37780/tests/dromaeo/cssquery-prototype.html) 07:48:48 INFO - PROCESS | 10376 | RSS: Main: 242155520 07:48:48 INFO - PROCESS | 10376 | 07:51:51 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37780/tests/dromaeo/cssquery-yui.html) 07:51:52 INFO - PROCESS | 10376 | RSS: Main: 215060480 07:51:52 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | Cycle 1(1): loaded http://localhost:37780/tests/dromaeo/cssquery-yui.html (next: http://localhost:37780/tests/dromaeo/cssquery-dojo.html) 07:54:55 INFO - PROCESS | 10376 | RSS: Main: 293068800 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | __start_tp_report 07:54:55 INFO - PROCESS | 10376 | _x_x_mozilla_page_load 07:54:55 INFO - PROCESS | 10376 | _x_x_mozilla_page_load_details 07:54:55 INFO - PROCESS | 10376 | |i|pagename|runs| 07:54:55 INFO - PROCESS | 10376 | |0;dojo.html;2653.601959706044;2677.8125531212822;2702.256879358176;2715.1040156748277;2718.9320266993323;4668.649851261152;4729.810807567702;4762.261849413338;4844.927326090107;4892.706437613741;4690.5074967128385;4707.90584188316;4743.359646447729;4800.063987522434;4823.831165909194;4300.247456695074;4346.78266086696;4379.64962802975;4411.602955733983;4508.954910450902;4439.156560253541;4461.776911154446;4463.955360446403;4507.864764057083;4520.864374068783;4339.435873336446;4354.9782251088545;4383.3424986252;4393.692441529094;4408.470983482002;4357.41174941382;4365.5416181300825;4379.75911324877;4400.053988392479;4414.139242847646;4406.09675016624;4413.757243351614;4415.072834704716;4415.116976604692;4456.242438785414;4641.234196357597;4713.34013238147;4824.831130910401;4862.489438608965;4874.366332376769;5122.078025955327;5167.276581278624;5206.687598744087;5209.557187639055;5216.321878155815;5165.044466773659;5179.2749015137915;5232.136697444917;5241.24002019705;5245.449227831099;4728.4562275338085;4754.001659651442;4798.064377446364;4836.975815120902;4883.609311255091;5273.709945952933;5290.550303224192;5309.283246761638;5319.9202011969855;5332.626716129911;5053.444121146671;5068.771905264198;5090.26191202281;5102.69383836971;5115.028144652504;4983.27742477346;5040.873978150576;5095.592352611782;5132.5124113209185;5191.532762051434;5044.672096313728;5068.467810879878;5072.82245121419;5079.4412614612365;5126;5035.77339019745;5042.168042273057;5046.4953504649975;5048.974755126274;5051.494850514919;3958.980205098956;3963.1677347756718;3994.6205110514456;3999.980000100039;4008.939865902014;3542;3554.2536067425613;3561.0207193021606;3584.426491761306;3608.188157664557;4494.640428765691;4495.617872480876;4497.257952437876;4504.346869703874;4548.044910568751;4961.255811628284;5122.538971492583;5143.6656617320505;5187.377514698261;5188.11801993662;4485.215087359699;4486.439195100613;4491.955080449219;4494.393256910275;4536.432945881765;4608.170529304757;4612.077584483117;4617.3304870793545;4625.838095666702;4679.81280748773;4670.206064968896;4717.764111794465;4776.570108690095;4778.163821331323;4796.592289655418;5119.923201151912;5138.563222126161;5149.588032957279;5157.432682405008;5210.5831533477985;4789.640776941674;4831.782569784438;4847.103285892122;4854.490278520846;4874.610031197567;4925.48282430354;4982.551570358685;5103.540681338697;5125.487451254845;5129.512696293846;5166.276721259102;5187.818426355059;5190.091733946469;5192.870178245574;5239.633225674166;4897.946941407615;5033.572146367454;5038.672486288379;5044.319016932667;5054;4952.380952380952;4968.925466118083;4969.975150124226;4996.325496057985;5000.87497812543;4915.6313276505125;4919.040787046635;4927.852164435073;4992.15133427311;4996.725180115129;4992.226204938241;5005.624578156726;5039.899202015866;5050.949490505048;5057.988402319625;4895.559399654048;4921.163402221702;4933.136701077369;4970.204767237225;4984.22744474607 07:54:55 INFO - PROCESS | 10376 | |1;ext.html;548.3323911814584;589.3958692340353;591.1221835574173;594.9524038076953;598.019248432571;27615.447691046193;30029.549556756665;30042.399152016947;39636.20727585447;40754.38868416969;41199.79400102995;41456;41800.58199418005;41820.58179418205;41839.58160418395;7850.528968261894;7997.960010199941;7999.40004499662;8012.038555373363;8015;7875.488093273919;7964.482308649919;7972.960135199345;7982.521048737094;7983;7991.280784729373;8020.839583208332;8034.558099304565;8042.155573664769;8042.839143217132;7973.800654983614;8013.559254241014;8022.478538894953;8029.518228906284;8030.036395632562;7931.246531579491;7995;7997;8001.279884810395;8002.319802816709;39078;39494.21011579753;39499.60500394988;39536.60463395358;39541.60458395408;2957.467655821951;3109.486934655779;3116.688331166888;3131.3111115554543;3215.935681286361;29524.409511809645;29624.259393515335;30221;30555.541666874793;30620.387592248255;3105.1305634422397;3108.937821243585;3160.336329370835;3181.984090079535;3213.678632136791;262285;262452;263274;263291;263546;32072.198195045312;51565.226521602206;52327;52327.47672523302;52344.47655523396;34100.658993410245;34223.31553368968;34241.828790855885;34321;34342.65657343445;13863;14053.718925621635;14077.225752583707;14082.647933801532;14088.15471071739;11493.138014648935;11698.649040528799;11699.590514331958;11700.941495292469;11729.120315976335;7869.567173805382;7885;7894.210578942175;7959.562224077616;7965.48224365426;3061.4642437573334;3072.3701641163507;3085.2595377109333;3111.9066428007195;3132.843357832099;859.5873980489275;927.8840144981878;968.5689868008668;991.4596544883057;991.613270824379;27266.454670906867;28253.29366765806;28420;28614.14157575276;28680.88139217238;807.9030516337959;948.8292107420731;959.4169620126846;965.584798536622;997.670768646345;15265.694686106215;15980.680386392207;16223.918880405523;16862.156892155344;16910.20880744193;402114;405023.82416615274;405263;405433;407304;51522;51593;52051;52076.479235207924;52128;1084.3927400655657;1177.6937996121071;1212.5816593275306;1235.765204611121;1242.099477878531;25313.49373012566;29501.11496655104;29589.408211836075;29917.55123673103;30011.849940750155;41512.584874150874;42230.78884605557;42254.78872605618;42256.57743422649;42267.788661057726;245945.77027115464;250443;250912;251673;252856;21577;21993.560128797653;21995.120195192652;24659.013639454937;24983.75016249814;34701.13247168841;35417.468737969466;41344.37983430191;42399.57600423956;45523;36349;36429;36687.26625467529;36769.63230367662;37274.44088338732;35175.92952842657;35598.64401355953;35671.46492802558;35929;36352.81823590865;26661.466770664865;34611.48082778811;34860.30279394449;35570.46644300286;35663.10842228861;30539.38921221519;32588.348233034732;32633;32803.8359808209;32882.50676239906;24731.381715457257;25207.621885671364;25210.117645882307;25365.492690145726;25681.10116145926 07:54:55 INFO - PROCESS | 10376 | |2;jquery.html;354.12531048310666;369.82987825600225;371.94978677878487;379.75695554844884;385.8745907580037;13079.73840523189;16440.17799110044;17080.743788843163;18519.166637501312;18520.722189167172;17767.11164441776;17842.37551685691;17871.19579618917;18229.817701822976;18243.452696419095;4940.35775349205;5324.5740340772645;5337.226102215196;5341.30563026806;5343.973280133594;3730.869419570302;5188.0920838853235;5962.403759624046;6293.276273228568;6308.053791931224;6117.124951272895;6286.748530058792;6313.936860631381;6337.144485494468;6357.93642063578;6263.592866463688;6287.18266625338;6337.683115844189;6374.298827129012;6384.042393640944;3382.120648631349;5154.871128221787;5448.291722076145;5461.1262198048125;5556.555475561945;20887.791122088736;21518.677219841717;21543;21593.892030539904;21844.781552184435;1831.2674930027963;1860.209411000333;1871.6069625378686;1915.52111972007;1934.806519348068;8758.2993360531;8988.46069235848;9294.070592940652;9317.44095354281;9688.612455501772;1611.943581974637;1685.2079522624347;1694.9491515254563;1717.9434647691705;1766.152246921485;63715.36284637187;65534;66032;67574.32425675729;74607.62696186539;8935.910640893639;9432.05679432065;9968.352057116264;10041.548130334153;10197.74505637365;12872.549460768829;13739.519116830863;13762.311884405739;14180.716385672229;14253.216073116078;7564.9243507565325;7565.735199268;7582.696692132253;7679.155292917774;7862.135165131831;7209.134903811471;7225.963870180615;7346.302101300368;7353.5955522446775;7362.779116626402;4300.978495107504;4390.363397307437;4413.1394378095965;4480.260756975128;4490.416245888014;1791.3461586520825;1824.4617837737899;1832.853371730285;1840.8711390202557;1851.6759567075708;822.1942496353607;872.5637181409295;891.407214202561;918.2791508665665;931.1666058877267;15892.046477211405;17146.39987600428;17704.90164221256;17791.822081779017;18225.7266141008;829.1087081387533;853.6073406233203;863.3050394432543;868.7567481105301;897.210454799772;6599.538032337787;9871.60513579463;9886.653967111117;10022.398656080659;10039.096481316716;394943;402552;404446;405709;406218;82329.58835205906;82860.58569707113;83318.58340708258;83714;84282.15717842743;889.9955500222587;897.5243121145803;898.2409863665192;912.3750231091724;920.2683866326287;15546.222688865737;15633.609159771097;15726.21368931526;15809.446669366516;16207.270672819515;28628.427431450837;36108;38482.80758596189;38690;39126.6087339123;47703.28445073257;48798.756006219744;50348.748256258485;50845.237321440945;51285.230721539956;7582.317591416799;7685.8462830741955;7699.6535155917;7718.6140692964;7742.7677169685;6616.966915165393;8380.622871970654;10028.896821349499;11739;11961.521539138337;9974.950125249326;10033.698989030341;10397.220208484243;10575.524101415609;10637.14902807758;10076;10204.795904082026;10211.438370889673;10275.280730348804;10493.685189444328;10163.136133428741;10437.843432348369;10470.214733894836;10837.40397774374;10955.945220273848;6682.69927853238;7115.2528984455885;7198.5680859148615;7833.529988200498;7994.880076798969;9400.95299523498;9990.200783937413;10005.249606279413;10821.458927053773;11057.944710276397 07:54:55 INFO - PROCESS | 10376 | |3;mootools.html;1376.889848812095;1425.1662777275294;1522.7411340072188;1659.369439612947;1732.2205007746518;7633.5419874807485;8043.356531477482;8113.107558168605;8129.065157506874;8129.309008734264;6777.796666100025;6986.196587392451;7536;7840.960795196016;7954.323882469983;2209.5028618560814;2240.630296001158;2246.067881829047;2251.549690061986;2254.1884921428273;2213.9889300553473;2215.125025614881;2262.7624099469567;2267.138487374795;2270.182734215681;1922.1254329280214;2135.2740068376747;2185.0604240176717;2185.3007037747925;2198.604251234777;2228.565429741201;2239.104358256694;2244.528648983707;2264.4338915271182;2269.296518079401;2199.791019853127;2218.4010317214425;2219.7780221977673;2219.955600887973;2223.1663126327626;8163.38774591908;8205.95897020517;8207.179282071806;8214.712485063053;8217.30152937001;4663.067386522709;4690.882727931795;4802.663813533054;4805.8558243252755;4812.350332705075;2785.080923295308;2837.304860309217;2892.5082735934943;2914.635670541182;2920.5765164051095;841.364769598955;843.8101427178897;852.7356519478982;1605.5263697209352;1626.8291829357865;10661.307015043998;10742.73143171427;10770.892291077067;10772.5690972361;10785.191110666732;3914.9608503915165;4010.598940106024;4026.174634199982;4167.979160104241;4168.541460439349;8401.579921003926;8410.03284622264;8415.200555947175;8430.241278284984;8432;4334.631556317685;4401.075774087413;4405.229084910128;4405.669574781904;4411.139827733561;4068.613481719232;4121.258173528794;4131.8967025824595;4133.6693064554765;4137.91724165521;3335.5497007903623;3426.9657303427143;3443.104792753902;3460.2214501736908;3470.5314782504543;906.5557876640398;1006.3157053203745;1015.2892974917587;1018.0532105142289;1024.5082360466868;611.8011646214998;660.6828722213364;688.2016860441863;760.9162992070868;814.4136221920209;5268.6575372600655;5367.677939323653;5417.241586177938;5508.504234618904;5620.156976453564;819.5656302159865;820.323233332503;839.1063517353998;858.5578427110044;897.9865302020474;3440.6559344065395;3577.481265216529;3585.0858031202397;3601.1177261571083;3618.511500947391;9802.607895684092;10044.397336159855;10146.036126568111;10151.9492402539;10212.438315892548;9921.702348929544;10041.497925103715;10055.497225138713;10056.69829905104;10058;7443.739469118555;7583.924160758432;7589.1651918290045;7591.127020392615;7594.278543538355;5100.9489905101955;5176.456472070378;5181.792728290826;5278.419373868948;5298.655587386807;9048.90951090507;9062.864057039282;9119.361644684808;9137.908620913706;9171;8764.474131551871;9117.589708463003;9133.178013978773;9378.343515953818;9410.95294523523;6767.492438067263;6915.688794004182;6924.272951340238;6928.4803639726215;6932.202796678245;7484.25157484269;7645.808854778675;7650.273224043707;7696.615169241628;7711.228877112469;5964.433378829004;6428.903566446601;6937.653117344214;6949.965250173716;7088.610126443095;6742.561733487308;6783.219929708147;6854.383105520327;6959.234484206632;7001.544899581511;6125.387461253839;6176.876462470816;6186.628802271878;6186.659733714689;6207.565470417027;4296.398504209351;4451.643868490578;4453.487848897418;4462.821487140478;4493.865184044484;4371.601087651921;4452.5992660660695;4457.175422546839;4547.15877562652;4593.6554758392585 07:54:55 INFO - PROCESS | 10376 | |4;prototype.html;301.0501866610843;302.2504189609766;303.2797106871181;304.5249410918965;306.6825835260505;4902.803887844487;4935.407751069868;4948.257761335802;4948.529889660476;4949.381327334083;4825.806967721296;4854.271859221119;4865;4865.440474345452;4867.756612169386;3645.763025403347;3772.566154892181;3796.7532110412735;3839.36650452675;3855.342202852772;3803.1633040731135;3844.2503711776217;3852.8073596320073;3867.7292589518743;3869.2648396804657;3806.1626442182815;3809.466674665549;3812.694984401241;3816.809159542012;3826.196498735255;3627.9455808162897;3695.5380577427686;3826.617338266179;3828.3874580067336;3834.3481608126685;3382.52644629752;3388.5086662434055;3397.8640854365794;3398.3373242217776;3401.9489707654407;4783.139034973703;4791.520847915181;4793.23308270675;4816.277558366238;4829.154897892855;4166.229247589205;4402.7358358498595;4422.84520041797;4453.866384008485;4466.151431228056;5147.22791581262;5148.922766158511;5152.92270615941;5166.302549155854;5174.9650069986155;3784.4512545680996;3787.9242415151816;3790.7915064671433;3791.1848952475075;3798.563165235978;5054.292399064134;5339.599530035224;5350.010248104113;5370.2750128732905;5412.810551630674;3684.2815650948346;3713.3316003119157;3714.86094250358;3715.4241092630687;3716.758410703296;3740.588535261119;3756.8309426075893;3761.1725420407465;3763.2661630982243;3764.3412402829395;4284.614384705329;4287.135096233149;4306;4308.763018033976;4315.201687687725;4964.975175124101;5047.217681259411;5095.617828662865;5106.795728170906;5111.642185047011;1342.5166939901628;1343.368616750126;1349.284879014124;1353.7613084028003;1356.2676154876256;873.7898011254458;881.5283823154582;893.6336102198197;898.2185498616245;911.3028533172129;4543.227651299287;4553.134904368159;4554.658400619966;4555.134524440346;4556.179887620194;5221.216817477409;5225.581953443715;5225.817096401608;5233.162693969023;5259.421463638997;4390.604845563915;4497.550244975476;4544.068465964469;4547.636189104864;4556.248219043887;2750.6974232834373;2764.1707487753592;2781.694013658496;2786.6934637190298;2795.566687163493;4860.927086093711;4865.635077369211;4876.122297986326;4895.751583346295;4900.485449027872;5135;5319;5333.866653333697;5347.973260133675;5386.272853164851;4887.633427492952;4907.533784290486;4911.9754401227765;4927.852164435073;4940.580050695731;5164.0962831505085;5170.3278573785165;5181.3782346118705;5228.189630607262;5229.555487783429;4881.51184881509;5061.077664809802;5119.897602047864;5123.820666276662;5144.922826157685;4868.294097355934;4869.634777391639;4887.780049897834;4902.509749025069;4910.9263361050325;3843.55799083109;3855.4795102661906;3856.749311294757;3857.1514266861245;3860.6718428933855;5010.298558201782;5229.294045303835;5240.135377662643;5338.46615338463;5352.892942141213;5176.689398636094;5181.222816577543;5189.662671926313;5190.273361729436;5194.558462530727;5187.870303242449;5191.974040129775;5199.48005199477;5200.869978250574;5203.323567936144;4827.9137194132445;5106.514881086291;5107.463716309882;5127.6410651254055;5141.871453213699;4986.576141028053;5058.3443692061965;5178.870528236825;5229.738513074407;5231.686098834082;5095.77069031887;5096.311997880239;5097.490250974873;5104.464031276662;5106.183010718267 07:54:55 INFO - PROCESS | 10376 | |5;yui.html;664.8371149068478;672.1900110367005;688.2773088257331;706.9434445244381;738.3502517784349;12944.546940857072;13644.317784110804;14133.434662613483;14150.433982640694;14610.19643919584;13232.206067635949;13284;13418.597442076729;13419.329033548333;13436.66408339792;624.201022690954;750.5496701978797;780.7774784186522;782.6204290918928;800.8438354520871;784.6665167303902;786.1666633368619;786.4416264452245;790.8418316336727;792.2434075457952;830.8130670599097;834.1533343656164;836.6067948064431;837.0206857976183;838.0237023867187;644.4232411991266;660.5508254387015;663.2902794010411;667.2893368562466;832.50881979632;586.5219845825638;599.9730012149464;602.5179856115091;603.6438501284264;603.7615142018922;13376.732465350737;13430.261335626537;13461.192328460324;13470.730585388237;13473.595792126252;12826.166299190523;13222.491261740068;13224;13246.139000964906;13311.933440332834;11381.317120972768;11513.539458421654;11700.707482312926;11802;11968.581099661556;3218.243712727507;3241.4003409369343;3319.1038419626566;4119.958800411988;4195;62042;62995.99999999954;63232.68383658052;63761.36238637647;64164.35835641584;10440.582376704999;10484.423356715453;10528.473576321154;10558.86680465841;10578.894211057945;18457.1694273758;18490.44528664142;18512.629747404975;18534.536636584195;18570.628587428175;6645.800625981228;6691.832704182434;6755.054292399068;6777.6272305023695;6926.8614627708175;3674.577423596267;3709.517762690833;3725.1245957200035;3731.626837316301;3768.076821178774;2954.1728316071535;3056.786024978275;3058.990533124064;3060.4338197433544;3061.5713800068006;524.9133892907628;532.9626926115135;538.7548665357253;541.0531569752933;557.0891592246625;509.21834983300454;546.4863028752959;552.7678375082475;602.7016626769689;655.4101308822098;8206.753797385969;8652.091530389218;8691.565421728888;8693.304535637133;8726.86909696355;546.7020473841766;547.5674217368314;558.6313033398019;559.5887023038064;597.229573849729;4011.618896204856;4027.939580906289;4099.3031184698675;4244.1723863846255;4339.652827773833;93288;94828.52585737166;95513.5224323874;98617;98892.50553747329;81857;84665;84792.15207847842;84918.15081849226;87076;48374.516254837705;50394.49605503898;60578.697106514184;76294.61852690812;76893.23106768973;7814.6483408247905;7897.131315555399;7993.160718124514;8013.959930200312;8018.879716804136;42682;43097.56902431061;43932.04611584973;44494.777526112164;45079.54920450754;58306.416935831796;66346.66826665835;66576.6671166641;66602.66698666476;68384.6580767093;11849.644510664693;12039.75920481568;12219.51121955112;12351.69120771988;12575.245485270912;13412.93293533526;13767.38046787917;13896.791548126585;14221.857781422053;14323.78514322265;12246.448909798903;12324.568640097554;12589.118761686594;12758.61724148277;13651.38568764388;11569.190156689288;11885.22746021506;11900.880991189977;12113.939430302793;12418.192817466836;12242;12753.362331883554;12958.28729419891;13157.671058223621;13264.20414775078;10272.743181420525;10631.627893023708;10645.467726613484;10802.837957430802;11005.724856878642;10391;10533.841992370273;10609.636722301952;10653.414062226651;10792.406417646791 07:54:55 INFO - PROCESS | 10376 | __end_tp_report 07:54:55 INFO - PROCESS | 10376 | __start_cc_report 07:54:55 INFO - PROCESS | 10376 | _x_x_mozilla_cycle_collect,1103 07:54:55 INFO - PROCESS | 10376 | __end_cc_report 07:54:55 INFO - PROCESS | 10376 | __startTimestamp1467816895448__endTimestamp 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | ------- Summary: start ------- 07:54:55 INFO - PROCESS | 10376 | Number of tests: 6 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#0] dojo.html Cycles:165 Average:4729.49 Median:4874.61 stddev:523.65 (10.7%) stddev-sans-first:499.29 07:54:55 INFO - PROCESS | 10376 | Values: 2653.6 2677.8 2702.3 2715.1 2718.9 4668.6 4729.8 4762.3 4844.9 4892.7 4690.5 4707.9 4743.4 4800.1 4823.8 4300.2 4346.8 4379.6 4411.6 4509.0 4439.2 4461.8 4464.0 4507.9 4520.9 4339.4 4355.0 4383.3 4393.7 4408.5 4357.4 4365.5 4379.8 4400.1 4414.1 4406.1 4413.8 4415.1 4415.1 4456.2 4641.2 4713.3 4824.8 4862.5 4874.4 5122.1 5167.3 5206.7 5209.6 5216.3 5165.0 5179.3 5232.1 5241.2 5245.4 4728.5 4754.0 4798.1 4837.0 4883.6 5273.7 5290.6 5309.3 5319.9 5332.6 5053.4 5068.8 5090.3 5102.7 5115.0 4983.3 5040.9 5095.6 5132.5 5191.5 5044.7 5068.5 5072.8 5079.4 5126.0 5035.8 5042.2 5046.5 5049.0 5051.5 3959.0 3963.2 3994.6 4000.0 4008.9 3542.0 3554.3 3561.0 3584.4 3608.2 4494.6 4495.6 4497.3 4504.3 4548.0 4961.3 5122.5 5143.7 5187.4 5188.1 4485.2 4486.4 4492.0 4494.4 4536.4 4608.2 4612.1 4617.3 4625.8 4679.8 4670.2 4717.8 4776.6 4778.2 4796.6 5119.9 5138.6 5149.6 5157.4 5210.6 4789.6 4831.8 4847.1 4854.5 4874.6 4925.5 4982.6 5103.5 5125.5 5129.5 5166.3 5187.8 5190.1 5192.9 5239.6 4897.9 5033.6 5038.7 5044.3 5054.0 4952.4 4968.9 4970.0 4996.3 5000.9 4915.6 4919.0 4927.9 4992.2 4996.7 4992.2 5005.6 5039.9 5050.9 5058.0 4895.6 4921.2 4933.1 4970.2 4984.2 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#1] ext.html Cycles:180 Average:45161.20 Median:35584.56 stddev:82905.55 (233.0%) stddev-sans-first:83070.45 07:54:55 INFO - PROCESS | 10376 | Values: 548.3 589.4 591.1 595.0 598.0 27615.4 30029.5 30042.4 39636.2 40754.4 41199.8 41456.0 41800.6 41820.6 41839.6 7850.5 7998.0 7999.4 8012.0 8015.0 7875.5 7964.5 7973.0 7982.5 7983.0 7991.3 8020.8 8034.6 8042.2 8042.8 7973.8 8013.6 8022.5 8029.5 8030.0 7931.2 7995.0 7997.0 8001.3 8002.3 39078.0 39494.2 39499.6 39536.6 39541.6 2957.5 3109.5 3116.7 3131.3 3215.9 29524.4 29624.3 30221.0 30555.5 30620.4 3105.1 3108.9 3160.3 3182.0 3213.7 262285.0 262452.0 263274.0 263291.0 263546.0 32072.2 51565.2 52327.0 52327.5 52344.5 34100.7 34223.3 34241.8 34321.0 34342.7 13863.0 14053.7 14077.2 14082.6 14088.2 11493.1 11698.6 11699.6 11700.9 11729.1 7869.6 7885.0 7894.2 7959.6 7965.5 3061.5 3072.4 3085.3 3111.9 3132.8 859.6 927.9 968.6 991.5 991.6 27266.5 28253.3 28420.0 28614.1 28680.9 807.9 948.8 959.4 965.6 997.7 15265.7 15980.7 16223.9 16862.2 16910.2 402114.0 405023.8 405263.0 405433.0 407304.0 51522.0 51593.0 52051.0 52076.5 52128.0 1084.4 1177.7 1212.6 1235.8 1242.1 25313.5 29501.1 29589.4 29917.6 30011.8 41512.6 42230.8 42254.8 42256.6 42267.8 245945.8 250443.0 250912.0 251673.0 252856.0 21577.0 21993.6 21995.1 24659.0 24983.8 34701.1 35417.5 41344.4 42399.6 45523.0 36349.0 36429.0 36687.3 36769.6 37274.4 35175.9 35598.6 35671.5 35929.0 36352.8 26661.5 34611.5 34860.3 35570.5 35663.1 30539.4 32588.3 32633.0 32803.8 32882.5 24731.4 25207.6 25210.1 25365.5 25681.1 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#2] jquery.html Cycles:180 Average:24812.16 Median:26096.85 stddev:66522.49 (254.9%) stddev-sans-first:66683.75 07:54:55 INFO - PROCESS | 10376 | Values: 354.1 369.8 371.9 379.8 385.9 13079.7 16440.2 17080.7 18519.2 18520.7 17767.1 17842.4 17871.2 18229.8 18243.5 4940.4 5324.6 5337.2 5341.3 5344.0 3730.9 5188.1 5962.4 6293.3 6308.1 6117.1 6286.7 6313.9 6337.1 6357.9 6263.6 6287.2 6337.7 6374.3 6384.0 3382.1 5154.9 5448.3 5461.1 5556.6 20887.8 21518.7 21543.0 21593.9 21844.8 1831.3 1860.2 1871.6 1915.5 1934.8 8758.3 8988.5 9294.1 9317.4 9688.6 1611.9 1685.2 1694.9 1717.9 1766.2 63715.4 65534.0 66032.0 67574.3 74607.6 8935.9 9432.1 9968.4 10041.5 10197.7 12872.5 13739.5 13762.3 14180.7 14253.2 7564.9 7565.7 7582.7 7679.2 7862.1 7209.1 7226.0 7346.3 7353.6 7362.8 4301.0 4390.4 4413.1 4480.3 4490.4 1791.3 1824.5 1832.9 1840.9 1851.7 822.2 872.6 891.4 918.3 931.2 15892.0 17146.4 17704.9 17791.8 18225.7 829.1 853.6 863.3 868.8 897.2 6599.5 9871.6 9886.7 10022.4 10039.1 394943.0 402552.0 404446.0 405709.0 406218.0 82329.6 82860.6 83318.6 83714.0 84282.2 890.0 897.5 898.2 912.4 920.3 15546.2 15633.6 15726.2 15809.4 16207.3 28628.4 36108.0 38482.8 38690.0 39126.6 47703.3 48798.8 50348.7 50845.2 51285.2 7582.3 7685.8 7699.7 7718.6 7742.8 6617.0 8380.6 10028.9 11739.0 11961.5 9975.0 10033.7 10397.2 10575.5 10637.1 10076.0 10204.8 10211.4 10275.3 10493.7 10163.1 10437.8 10470.2 10837.4 10955.9 6682.7 7115.3 7198.6 7833.5 7994.9 9401.0 9990.2 10005.2 10821.5 11057.9 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#3] mootools.html Cycles:180 Average:5167.76 Median:4746.77 stddev:2936.98 (61.9%) stddev-sans-first:2931.40 07:54:55 INFO - PROCESS | 10376 | Values: 1376.9 1425.2 1522.7 1659.4 1732.2 7633.5 8043.4 8113.1 8129.1 8129.3 6777.8 6986.2 7536.0 7841.0 7954.3 2209.5 2240.6 2246.1 2251.5 2254.2 2214.0 2215.1 2262.8 2267.1 2270.2 1922.1 2135.3 2185.1 2185.3 2198.6 2228.6 2239.1 2244.5 2264.4 2269.3 2199.8 2218.4 2219.8 2220.0 2223.2 8163.4 8206.0 8207.2 8214.7 8217.3 4663.1 4690.9 4802.7 4805.9 4812.4 2785.1 2837.3 2892.5 2914.6 2920.6 841.4 843.8 852.7 1605.5 1626.8 10661.3 10742.7 10770.9 10772.6 10785.2 3915.0 4010.6 4026.2 4168.0 4168.5 8401.6 8410.0 8415.2 8430.2 8432.0 4334.6 4401.1 4405.2 4405.7 4411.1 4068.6 4121.3 4131.9 4133.7 4137.9 3335.5 3427.0 3443.1 3460.2 3470.5 906.6 1006.3 1015.3 1018.1 1024.5 611.8 660.7 688.2 760.9 814.4 5268.7 5367.7 5417.2 5508.5 5620.2 819.6 820.3 839.1 858.6 898.0 3440.7 3577.5 3585.1 3601.1 3618.5 9802.6 10044.4 10146.0 10151.9 10212.4 9921.7 10041.5 10055.5 10056.7 10058.0 7443.7 7583.9 7589.2 7591.1 7594.3 5100.9 5176.5 5181.8 5278.4 5298.7 9048.9 9062.9 9119.4 9137.9 9171.0 8764.5 9117.6 9133.2 9378.3 9411.0 6767.5 6915.7 6924.3 6928.5 6932.2 7484.3 7645.8 7650.3 7696.6 7711.2 5964.4 6428.9 6937.7 6950.0 7088.6 6742.6 6783.2 6854.4 6959.2 7001.5 6125.4 6176.9 6186.6 6186.7 6207.6 4296.4 4451.6 4453.5 4462.8 4493.9 4371.6 4452.6 4457.2 4547.2 4593.7 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#4] prototype.html Cycles:180 Average:4258.22 Median:4865.54 stddev:1224.87 (25.2%) stddev-sans-first:1191.75 07:54:55 INFO - PROCESS | 10376 | Values: 301.1 302.3 303.3 304.5 306.7 4902.8 4935.4 4948.3 4948.5 4949.4 4825.8 4854.3 4865.0 4865.4 4867.8 3645.8 3772.6 3796.8 3839.4 3855.3 3803.2 3844.3 3852.8 3867.7 3869.3 3806.2 3809.5 3812.7 3816.8 3826.2 3627.9 3695.5 3826.6 3828.4 3834.3 3382.5 3388.5 3397.9 3398.3 3401.9 4783.1 4791.5 4793.2 4816.3 4829.2 4166.2 4402.7 4422.8 4453.9 4466.2 5147.2 5148.9 5152.9 5166.3 5175.0 3784.5 3787.9 3790.8 3791.2 3798.6 5054.3 5339.6 5350.0 5370.3 5412.8 3684.3 3713.3 3714.9 3715.4 3716.8 3740.6 3756.8 3761.2 3763.3 3764.3 4284.6 4287.1 4306.0 4308.8 4315.2 4965.0 5047.2 5095.6 5106.8 5111.6 1342.5 1343.4 1349.3 1353.8 1356.3 873.8 881.5 893.6 898.2 911.3 4543.2 4553.1 4554.7 4555.1 4556.2 5221.2 5225.6 5225.8 5233.2 5259.4 4390.6 4497.6 4544.1 4547.6 4556.2 2750.7 2764.2 2781.7 2786.7 2795.6 4860.9 4865.6 4876.1 4895.8 4900.5 5135.0 5319.0 5333.9 5348.0 5386.3 4887.6 4907.5 4912.0 4927.9 4940.6 5164.1 5170.3 5181.4 5228.2 5229.6 4881.5 5061.1 5119.9 5123.8 5144.9 4868.3 4869.6 4887.8 4902.5 4910.9 3843.6 3855.5 3856.7 3857.2 3860.7 5010.3 5229.3 5240.1 5338.5 5352.9 5176.7 5181.2 5189.7 5190.3 5194.6 5187.9 5192.0 5199.5 5200.9 5203.3 4827.9 5106.5 5107.5 5127.6 5141.9 4986.6 5058.3 5178.9 5229.7 5231.7 5095.8 5096.3 5097.5 5104.5 5106.2 07:54:55 INFO - PROCESS | 10376 | 07:54:55 INFO - PROCESS | 10376 | [#5] yui.html Cycles:180 Average:17753.54 Median:23718.61 stddev:24752.83 (104.4%) stddev-sans-first:24789.01 07:54:55 INFO - PROCESS | 10376 | Values: 664.8 672.2 688.3 706.9 738.4 12944.5 13644.3 14133.4 14150.4 14610.2 13232.2 13284.0 13418.6 13419.3 13436.7 624.2 750.5 780.8 782.6 800.8 784.7 786.2 786.4 790.8 792.2 830.8 834.2 836.6 837.0 838.0 644.4 660.6 663.3 667.3 832.5 586.5 600.0 602.5 603.6 603.8 13376.7 13430.3 13461.2 13470.7 13473.6 12826.2 13222.5 13224.0 13246.1 13311.9 11381.3 11513.5 11700.7 11802.0 11968.6 3218.2 3241.4 3319.1 4120.0 4195.0 62042.0 62996.0 63232.7 63761.4 64164.4 10440.6 10484.4 10528.5 10558.9 10578.9 18457.2 18490.4 18512.6 18534.5 18570.6 6645.8 6691.8 6755.1 6777.6 6926.9 3674.6 3709.5 3725.1 3731.6 3768.1 2954.2 3056.8 3059.0 3060.4 3061.6 524.9 533.0 538.8 541.1 557.1 509.2 546.5 552.8 602.7 655.4 8206.8 8652.1 8691.6 8693.3 8726.9 546.7 547.6 558.6 559.6 597.2 4011.6 4027.9 4099.3 4244.2 4339.7 93288.0 94828.5 95513.5 98617.0 98892.5 81857.0 84665.0 84792.2 84918.2 87076.0 48374.5 50394.5 60578.7 76294.6 76893.2 7814.6 7897.1 7993.2 8014.0 8018.9 42682.0 43097.6 43932.0 44494.8 45079.5 58306.4 66346.7 66576.7 66602.7 68384.7 11849.6 12039.8 12219.5 12351.7 12575.2 13412.9 13767.4 13896.8 14221.9 14323.8 12246.4 12324.6 12589.1 12758.6 13651.4 11569.2 11885.2 11900.9 12113.9 12418.2 12242.0 12753.4 12958.3 13157.7 13264.2 10272.7 10631.6 10645.5 10802.8 11005.7 10391.0 10533.8 10609.6 10653.4 10792.4 07:54:55 INFO - PROCESS | 10376 | -------- Summary: end -------- 07:54:55 INFO - PROCESS | 10376 | 07:54:56 INFO - TEST-INFO | 10376: exit 0 07:54:56 INFO - TEST-OK | dromaeo_css | took 1120503ms 07:54:56 INFO - TEST-START | kraken 07:54:56 INFO - operating with platform_type : linux_ 07:54:56 INFO - Initialising browser for kraken test... 07:54:56 INFO - TEST-INFO | started process 10566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply6sSH/profile http://localhost:37780/getInfo.html) 07:55:00 INFO - PROCESS | 10566 | __metrics Screen width/height:1600/1200 07:55:00 INFO - PROCESS | 10566 | colorDepth:24 07:55:00 INFO - PROCESS | 10566 | Browser inner width/height: 1024/697 07:55:00 INFO - PROCESS | 10566 | __metrics 07:55:01 INFO - PROCESS | 10566 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:02 INFO - TEST-INFO | 10566: exit 0 07:55:02 INFO - Browser initialized. 07:55:02 INFO - Running cycle 1/1 for kraken test... 07:55:02 INFO - TEST-INFO | started process 10647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply6sSH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:14 INFO - PROCESS | 10647 | RSS: Main: 158547968 07:55:14 INFO - PROCESS | 10647 | 07:55:16 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37780/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:17 INFO - PROCESS | 10647 | RSS: Main: 216928256 07:55:17 INFO - PROCESS | 10647 | 07:55:20 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37780/tests/kraken/driver.html?testName=audio-dft) 07:55:21 INFO - PROCESS | 10647 | RSS: Main: 203632640 07:55:21 INFO - PROCESS | 10647 | 07:55:24 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37780/tests/kraken/driver.html?testName=audio-fft) 07:55:25 INFO - PROCESS | 10647 | RSS: Main: 271360000 07:55:25 INFO - PROCESS | 10647 | 07:55:27 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37780/tests/kraken/driver.html?testName=audio-oscillator) 07:55:27 INFO - PROCESS | 10647 | RSS: Main: 181751808 07:55:27 INFO - PROCESS | 10647 | 07:55:30 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:30 INFO - PROCESS | 10647 | RSS: Main: 185266176 07:55:30 INFO - PROCESS | 10647 | 07:55:33 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37780/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:34 INFO - PROCESS | 10647 | RSS: Main: 221773824 07:55:34 INFO - PROCESS | 10647 | 07:55:38 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37780/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:38 INFO - PROCESS | 10647 | RSS: Main: 217227264 07:55:38 INFO - PROCESS | 10647 | 07:55:41 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37780/tests/kraken/driver.html?testName=json-parse-financial) 07:55:42 INFO - PROCESS | 10647 | RSS: Main: 220221440 07:55:42 INFO - PROCESS | 10647 | 07:55:43 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:44 INFO - PROCESS | 10647 | RSS: Main: 204689408 07:55:44 INFO - PROCESS | 10647 | 07:55:46 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:46 INFO - PROCESS | 10647 | RSS: Main: 210006016 07:55:46 INFO - PROCESS | 10647 | 07:55:49 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:49 INFO - PROCESS | 10647 | RSS: Main: 212701184 07:55:49 INFO - PROCESS | 10647 | 07:55:52 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:53 INFO - PROCESS | 10647 | RSS: Main: 230445056 07:55:53 INFO - PROCESS | 10647 | 07:55:56 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:56 INFO - PROCESS | 10647 | RSS: Main: 224796672 07:55:56 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | Cycle 1(1): loaded http://localhost:37780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37780/tests/kraken/driver.html?testName=ai-astar) 07:55:58 INFO - PROCESS | 10647 | RSS: Main: 267247616 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | __start_tp_report 07:55:58 INFO - PROCESS | 10647 | _x_x_mozilla_page_load 07:55:58 INFO - PROCESS | 10647 | _x_x_mozilla_page_load_details 07:55:58 INFO - PROCESS | 10647 | |i|pagename|runs| 07:55:58 INFO - PROCESS | 10647 | |0;ai-astar;103;113;112;112;112;111;111;112;112;113 07:55:58 INFO - PROCESS | 10647 | |1;audio-beat-detection;154;122;125;178;123;122;157;124;170;126 07:55:58 INFO - PROCESS | 10647 | |2;audio-dft;163;161;160;160;161;161;162;162;161;161 07:55:58 INFO - PROCESS | 10647 | |3;audio-fft;75;77;76;102;76;75;76;76;98;77 07:55:58 INFO - PROCESS | 10647 | |4;audio-oscillator;86;87;119;86;87;85;123;84;85;124 07:55:58 INFO - PROCESS | 10647 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;116;117;116 07:55:58 INFO - PROCESS | 10647 | |6;imaging-darkroom;147;148;146;146;146;147;146;146;147;147 07:55:58 INFO - PROCESS | 10647 | |7;imaging-desaturate;95;95;95;95;95;95;95;97;95;95 07:55:58 INFO - PROCESS | 10647 | |8;json-parse-financial;65;65;64;64;64;65;65;65;64;65 07:55:58 INFO - PROCESS | 10647 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;66;65;65 07:55:58 INFO - PROCESS | 10647 | |10;stanford-crypto-aes;88;82;78;81;78;78;84;79;78;79 07:55:58 INFO - PROCESS | 10647 | |11;stanford-crypto-ccm;132;128;124;140;135;127;127;127;174;126 07:55:58 INFO - PROCESS | 10647 | |12;stanford-crypto-pbkdf2;170;166;169;168;164;168;168;170;168;163 07:55:58 INFO - PROCESS | 10647 | |13;stanford-crypto-sha256-iterative;67;69;68;66;70;71;66;66;65;65 07:55:58 INFO - PROCESS | 10647 | __end_tp_report 07:55:58 INFO - PROCESS | 10647 | __start_cc_report 07:55:58 INFO - PROCESS | 10647 | _x_x_mozilla_cycle_collect,1931 07:55:58 INFO - PROCESS | 10647 | __end_cc_report 07:55:58 INFO - PROCESS | 10647 | __startTimestamp1467816958610__endTimestamp 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | ------- Summary: start ------- 07:55:58 INFO - PROCESS | 10647 | Number of tests: 14 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 07:55:58 INFO - PROCESS | 10647 | Values: 103.0 113.0 112.0 112.0 112.0 111.0 111.0 112.0 112.0 113.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:140.00 stddev:22.22 (15.9%) stddev-sans-first:22.99 07:55:58 INFO - PROCESS | 10647 | Values: 154.0 122.0 125.0 178.0 123.0 122.0 157.0 124.0 170.0 126.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 07:55:58 INFO - PROCESS | 10647 | Values: 163.0 161.0 160.0 160.0 161.0 161.0 162.0 162.0 161.0 161.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:10.18 (13.4%) stddev-sans-first:10.58 07:55:58 INFO - PROCESS | 10647 | Values: 75.0 77.0 76.0 102.0 76.0 75.0 76.0 76.0 98.0 77.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.50 stddev:17.60 (20.6%) stddev-sans-first:18.24 07:55:58 INFO - PROCESS | 10647 | Values: 86.0 87.0 119.0 86.0 87.0 85.0 123.0 84.0 85.0 124.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:55:58 INFO - PROCESS | 10647 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:55:58 INFO - PROCESS | 10647 | Values: 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:55:58 INFO - PROCESS | 10647 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:55:58 INFO - PROCESS | 10647 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 07:55:58 INFO - PROCESS | 10647 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 66.0 65.0 65.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:3.34 (4.2%) stddev-sans-first:2.18 07:55:58 INFO - PROCESS | 10647 | Values: 88.0 82.0 78.0 81.0 78.0 78.0 84.0 79.0 78.0 79.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:130.00 stddev:14.86 (11.4%) stddev-sans-first:15.75 07:55:58 INFO - PROCESS | 10647 | Values: 132.0 128.0 124.0 140.0 135.0 127.0 127.0 127.0 174.0 126.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:2.37 (1.4%) stddev-sans-first:2.32 07:55:58 INFO - PROCESS | 10647 | Values: 170.0 166.0 169.0 168.0 164.0 168.0 168.0 170.0 168.0 163.0 07:55:58 INFO - PROCESS | 10647 | 07:55:58 INFO - PROCESS | 10647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.11 (3.1%) stddev-sans-first:2.24 07:55:58 INFO - PROCESS | 10647 | Values: 67.0 69.0 68.0 66.0 70.0 71.0 66.0 66.0 65.0 65.0 07:55:58 INFO - PROCESS | 10647 | -------- Summary: end -------- 07:55:58 INFO - PROCESS | 10647 | 07:55:59 INFO - TEST-INFO | 10647: exit 0 07:55:59 INFO - TEST-OK | kraken | took 63405ms 07:55:59 INFO - SUITE-END | took 1183s 07:55:59 INFO - Completed test suite (00:19:44) 07:55:59 INFO - javascript benchmark 07:55:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.601959706044, 2677.8125531212822, 2702.256879358176, 2715.1040156748277, 2718.9320266993323, 4668.649851261152, 4729.810807567702, 4762.261849413338, 4844.927326090107, 4892.706437613741, 4690.5074967128385, 4707.90584188316, 4743.359646447729, 4800.063987522434, 4823.831165909194, 4300.247456695074, 4346.78266086696, 4379.64962802975, 4411.602955733983, 4508.954910450902, 4439.156560253541, 4461.776911154446, 4463.955360446403, 4507.864764057083, 4520.864374068783, 4339.435873336446, 4354.9782251088545, 4383.3424986252, 4393.692441529094, 4408.470983482002, 4357.41174941382, 4365.5416181300825, 4379.75911324877, 4400.053988392479, 4414.139242847646, 4406.09675016624, 4413.757243351614, 4415.072834704716, 4415.116976604692, 4456.242438785414, 4641.234196357597, 4713.34013238147, 4824.831130910401, 4862.489438608965, 4874.366332376769, 5122.078025955327, 5167.276581278624, 5206.687598744087, 5209.557187639055, 5216.321878155815, 5165.044466773659, 5179.2749015137915, 5232.136697444917, 5241.24002019705, 5245.449227831099, 4728.4562275338085, 4754.001659651442, 4798.064377446364, 4836.975815120902, 4883.609311255091, 5273.709945952933, 5290.550303224192, 5309.283246761638, 5319.9202011969855, 5332.626716129911, 5053.444121146671, 5068.771905264198, 5090.26191202281, 5102.69383836971, 5115.028144652504, 4983.27742477346, 5040.873978150576, 5095.592352611782, 5132.5124113209185, 5191.532762051434, 5044.672096313728, 5068.467810879878, 5072.82245121419, 5079.4412614612365, 5126.0, 5035.77339019745, 5042.168042273057, 5046.4953504649975, 5048.974755126274, 5051.494850514919, 3958.980205098956, 3963.1677347756718, 3994.6205110514456, 3999.980000100039, 4008.939865902014, 3542.0, 3554.2536067425613, 3561.0207193021606, 3584.426491761306, 3608.188157664557, 4494.640428765691, 4495.617872480876, 4497.257952437876, 4504.346869703874, 4548.044910568751, 4961.255811628284, 5122.538971492583, 5143.6656617320505, 5187.377514698261, 5188.11801993662, 4485.215087359699, 4486.439195100613, 4491.955080449219, 4494.393256910275, 4536.432945881765, 4608.170529304757, 4612.077584483117, 4617.3304870793545, 4625.838095666702, 4679.81280748773, 4670.206064968896, 4717.764111794465, 4776.570108690095, 4778.163821331323, 4796.592289655418, 5119.923201151912, 5138.563222126161, 5149.588032957279, 5157.432682405008, 5210.5831533477985, 4789.640776941674, 4831.782569784438, 4847.103285892122, 4854.490278520846, 4874.610031197567, 4925.48282430354, 4982.551570358685, 5103.540681338697, 5125.487451254845, 5129.512696293846, 5166.276721259102, 5187.818426355059, 5190.091733946469, 5192.870178245574, 5239.633225674166, 4897.946941407615, 5033.572146367454, 5038.672486288379, 5044.319016932667, 5054.0, 4952.380952380952, 4968.925466118083, 4969.975150124226, 4996.325496057985, 5000.87497812543, 4915.6313276505125, 4919.040787046635, 4927.852164435073, 4992.15133427311, 4996.725180115129, 4992.226204938241, 5005.624578156726, 5039.899202015866, 5050.949490505048, 5057.988402319625, 4895.559399654048, 4921.163402221702, 4933.136701077369, 4970.204767237225, 4984.22744474607], "value": 4694.540734490545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3323911814584, 589.3958692340353, 591.1221835574173, 594.9524038076953, 598.019248432571, 27615.447691046193, 30029.549556756665, 30042.399152016947, 39636.20727585447, 40754.38868416969, 41199.79400102995, 41456.0, 41800.58199418005, 41820.58179418205, 41839.58160418395, 7850.528968261894, 7997.960010199941, 7999.40004499662, 8012.038555373363, 8015.0, 7875.488093273919, 7964.482308649919, 7972.960135199345, 7982.521048737094, 7983.0, 7991.280784729373, 8020.839583208332, 8034.558099304565, 8042.155573664769, 8042.839143217132, 7973.800654983614, 8013.559254241014, 8022.478538894953, 8029.518228906284, 8030.036395632562, 7931.246531579491, 7995.0, 7997.0, 8001.279884810395, 8002.319802816709, 39078.0, 39494.21011579753, 39499.60500394988, 39536.60463395358, 39541.60458395408, 2957.467655821951, 3109.486934655779, 3116.688331166888, 3131.3111115554543, 3215.935681286361, 29524.409511809645, 29624.259393515335, 30221.0, 30555.541666874793, 30620.387592248255, 3105.1305634422397, 3108.937821243585, 3160.336329370835, 3181.984090079535, 3213.678632136791, 262285.0, 262452.0, 263274.0, 263291.0, 263546.0, 32072.198195045312, 51565.226521602206, 52327.0, 52327.47672523302, 52344.47655523396, 34100.658993410245, 34223.31553368968, 34241.828790855885, 34321.0, 34342.65657343445, 13863.0, 14053.718925621635, 14077.225752583707, 14082.647933801532, 14088.15471071739, 11493.138014648935, 11698.649040528799, 11699.590514331958, 11700.941495292469, 11729.120315976335, 7869.567173805382, 7885.0, 7894.210578942175, 7959.562224077616, 7965.48224365426, 3061.4642437573334, 3072.3701641163507, 3085.2595377109333, 3111.9066428007195, 3132.843357832099, 859.5873980489275, 927.8840144981878, 968.5689868008668, 991.4596544883057, 991.613270824379, 27266.454670906867, 28253.29366765806, 28420.0, 28614.14157575276, 28680.88139217238, 807.9030516337959, 948.8292107420731, 959.4169620126846, 965.584798536622, 997.670768646345, 15265.694686106215, 15980.680386392207, 16223.918880405523, 16862.156892155344, 16910.20880744193, 402114.0, 405023.82416615274, 405263.0, 405433.0, 407304.0, 51522.0, 51593.0, 52051.0, 52076.479235207924, 52128.0, 1084.3927400655657, 1177.6937996121071, 1212.5816593275306, 1235.765204611121, 1242.099477878531, 25313.49373012566, 29501.11496655104, 29589.408211836075, 29917.55123673103, 30011.849940750155, 41512.584874150874, 42230.78884605557, 42254.78872605618, 42256.57743422649, 42267.788661057726, 245945.77027115464, 250443.0, 250912.0, 251673.0, 252856.0, 21577.0, 21993.560128797653, 21995.120195192652, 24659.013639454937, 24983.75016249814, 34701.13247168841, 35417.468737969466, 41344.37983430191, 42399.57600423956, 45523.0, 36349.0, 36429.0, 36687.26625467529, 36769.63230367662, 37274.44088338732, 35175.92952842657, 35598.64401355953, 35671.46492802558, 35929.0, 36352.81823590865, 26661.466770664865, 34611.48082778811, 34860.30279394449, 35570.46644300286, 35663.10842228861, 30539.38921221519, 32588.348233034732, 32633.0, 32803.8359808209, 32882.50676239906, 24731.381715457257, 25207.621885671364, 25210.117645882307, 25365.492690145726, 25681.10116145926], "value": 16407.217063541637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.12531048310666, 369.82987825600225, 371.94978677878487, 379.75695554844884, 385.8745907580037, 13079.73840523189, 16440.17799110044, 17080.743788843163, 18519.166637501312, 18520.722189167172, 17767.11164441776, 17842.37551685691, 17871.19579618917, 18229.817701822976, 18243.452696419095, 4940.35775349205, 5324.5740340772645, 5337.226102215196, 5341.30563026806, 5343.973280133594, 3730.869419570302, 5188.0920838853235, 5962.403759624046, 6293.276273228568, 6308.053791931224, 6117.124951272895, 6286.748530058792, 6313.936860631381, 6337.144485494468, 6357.93642063578, 6263.592866463688, 6287.18266625338, 6337.683115844189, 6374.298827129012, 6384.042393640944, 3382.120648631349, 5154.871128221787, 5448.291722076145, 5461.1262198048125, 5556.555475561945, 20887.791122088736, 21518.677219841717, 21543.0, 21593.892030539904, 21844.781552184435, 1831.2674930027963, 1860.209411000333, 1871.6069625378686, 1915.52111972007, 1934.806519348068, 8758.2993360531, 8988.46069235848, 9294.070592940652, 9317.44095354281, 9688.612455501772, 1611.943581974637, 1685.2079522624347, 1694.9491515254563, 1717.9434647691705, 1766.152246921485, 63715.36284637187, 65534.0, 66032.0, 67574.32425675729, 74607.62696186539, 8935.910640893639, 9432.05679432065, 9968.352057116264, 10041.548130334153, 10197.74505637365, 12872.549460768829, 13739.519116830863, 13762.311884405739, 14180.716385672229, 14253.216073116078, 7564.9243507565325, 7565.735199268, 7582.696692132253, 7679.155292917774, 7862.135165131831, 7209.134903811471, 7225.963870180615, 7346.302101300368, 7353.5955522446775, 7362.779116626402, 4300.978495107504, 4390.363397307437, 4413.1394378095965, 4480.260756975128, 4490.416245888014, 1791.3461586520825, 1824.4617837737899, 1832.853371730285, 1840.8711390202557, 1851.6759567075708, 822.1942496353607, 872.5637181409295, 891.407214202561, 918.2791508665665, 931.1666058877267, 15892.046477211405, 17146.39987600428, 17704.90164221256, 17791.822081779017, 18225.7266141008, 829.1087081387533, 853.6073406233203, 863.3050394432543, 868.7567481105301, 897.210454799772, 6599.538032337787, 9871.60513579463, 9886.653967111117, 10022.398656080659, 10039.096481316716, 394943.0, 402552.0, 404446.0, 405709.0, 406218.0, 82329.58835205906, 82860.58569707113, 83318.58340708258, 83714.0, 84282.15717842743, 889.9955500222587, 897.5243121145803, 898.2409863665192, 912.3750231091724, 920.2683866326287, 15546.222688865737, 15633.609159771097, 15726.21368931526, 15809.446669366516, 16207.270672819515, 28628.427431450837, 36108.0, 38482.80758596189, 38690.0, 39126.6087339123, 47703.28445073257, 48798.756006219744, 50348.748256258485, 50845.237321440945, 51285.230721539956, 7582.317591416799, 7685.8462830741955, 7699.6535155917, 7718.6140692964, 7742.7677169685, 6616.966915165393, 8380.622871970654, 10028.896821349499, 11739.0, 11961.521539138337, 9974.950125249326, 10033.698989030341, 10397.220208484243, 10575.524101415609, 10637.14902807758, 10076.0, 10204.795904082026, 10211.438370889673, 10275.280730348804, 10493.685189444328, 10163.136133428741, 10437.843432348369, 10470.214733894836, 10837.40397774374, 10955.945220273848, 6682.69927853238, 7115.2528984455885, 7198.5680859148615, 7833.529988200498, 7994.880076798969, 9400.95299523498, 9990.200783937413, 10005.249606279413, 10821.458927053773, 11057.944710276397], "value": 8280.094537166906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.889848812095, 1425.1662777275294, 1522.7411340072188, 1659.369439612947, 1732.2205007746518, 7633.5419874807485, 8043.356531477482, 8113.107558168605, 8129.065157506874, 8129.309008734264, 6777.796666100025, 6986.196587392451, 7536.0, 7840.960795196016, 7954.323882469983, 2209.5028618560814, 2240.630296001158, 2246.067881829047, 2251.549690061986, 2254.1884921428273, 2213.9889300553473, 2215.125025614881, 2262.7624099469567, 2267.138487374795, 2270.182734215681, 1922.1254329280214, 2135.2740068376747, 2185.0604240176717, 2185.3007037747925, 2198.604251234777, 2228.565429741201, 2239.104358256694, 2244.528648983707, 2264.4338915271182, 2269.296518079401, 2199.791019853127, 2218.4010317214425, 2219.7780221977673, 2219.955600887973, 2223.1663126327626, 8163.38774591908, 8205.95897020517, 8207.179282071806, 8214.712485063053, 8217.30152937001, 4663.067386522709, 4690.882727931795, 4802.663813533054, 4805.8558243252755, 4812.350332705075, 2785.080923295308, 2837.304860309217, 2892.5082735934943, 2914.635670541182, 2920.5765164051095, 841.364769598955, 843.8101427178897, 852.7356519478982, 1605.5263697209352, 1626.8291829357865, 10661.307015043998, 10742.73143171427, 10770.892291077067, 10772.5690972361, 10785.191110666732, 3914.9608503915165, 4010.598940106024, 4026.174634199982, 4167.979160104241, 4168.541460439349, 8401.579921003926, 8410.03284622264, 8415.200555947175, 8430.241278284984, 8432.0, 4334.631556317685, 4401.075774087413, 4405.229084910128, 4405.669574781904, 4411.139827733561, 4068.613481719232, 4121.258173528794, 4131.8967025824595, 4133.6693064554765, 4137.91724165521, 3335.5497007903623, 3426.9657303427143, 3443.104792753902, 3460.2214501736908, 3470.5314782504543, 906.5557876640398, 1006.3157053203745, 1015.2892974917587, 1018.0532105142289, 1024.5082360466868, 611.8011646214998, 660.6828722213364, 688.2016860441863, 760.9162992070868, 814.4136221920209, 5268.6575372600655, 5367.677939323653, 5417.241586177938, 5508.504234618904, 5620.156976453564, 819.5656302159865, 820.323233332503, 839.1063517353998, 858.5578427110044, 897.9865302020474, 3440.6559344065395, 3577.481265216529, 3585.0858031202397, 3601.1177261571083, 3618.511500947391, 9802.607895684092, 10044.397336159855, 10146.036126568111, 10151.9492402539, 10212.438315892548, 9921.702348929544, 10041.497925103715, 10055.497225138713, 10056.69829905104, 10058.0, 7443.739469118555, 7583.924160758432, 7589.1651918290045, 7591.127020392615, 7594.278543538355, 5100.9489905101955, 5176.456472070378, 5181.792728290826, 5278.419373868948, 5298.655587386807, 9048.90951090507, 9062.864057039282, 9119.361644684808, 9137.908620913706, 9171.0, 8764.474131551871, 9117.589708463003, 9133.178013978773, 9378.343515953818, 9410.95294523523, 6767.492438067263, 6915.688794004182, 6924.272951340238, 6928.4803639726215, 6932.202796678245, 7484.25157484269, 7645.808854778675, 7650.273224043707, 7696.615169241628, 7711.228877112469, 5964.433378829004, 6428.903566446601, 6937.653117344214, 6949.965250173716, 7088.610126443095, 6742.561733487308, 6783.219929708147, 6854.383105520327, 6959.234484206632, 7001.544899581511, 6125.387461253839, 6176.876462470816, 6186.628802271878, 6186.659733714689, 6207.565470417027, 4296.398504209351, 4451.643868490578, 4453.487848897418, 4462.821487140478, 4493.865184044484, 4371.601087651921, 4452.5992660660695, 4457.175422546839, 4547.15877562652, 4593.6554758392585], "value": 4140.3856352070825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.0501866610843, 302.2504189609766, 303.2797106871181, 304.5249410918965, 306.6825835260505, 4902.803887844487, 4935.407751069868, 4948.257761335802, 4948.529889660476, 4949.381327334083, 4825.806967721296, 4854.271859221119, 4865.0, 4865.440474345452, 4867.756612169386, 3645.763025403347, 3772.566154892181, 3796.7532110412735, 3839.36650452675, 3855.342202852772, 3803.1633040731135, 3844.2503711776217, 3852.8073596320073, 3867.7292589518743, 3869.2648396804657, 3806.1626442182815, 3809.466674665549, 3812.694984401241, 3816.809159542012, 3826.196498735255, 3627.9455808162897, 3695.5380577427686, 3826.617338266179, 3828.3874580067336, 3834.3481608126685, 3382.52644629752, 3388.5086662434055, 3397.8640854365794, 3398.3373242217776, 3401.9489707654407, 4783.139034973703, 4791.520847915181, 4793.23308270675, 4816.277558366238, 4829.154897892855, 4166.229247589205, 4402.7358358498595, 4422.84520041797, 4453.866384008485, 4466.151431228056, 5147.22791581262, 5148.922766158511, 5152.92270615941, 5166.302549155854, 5174.9650069986155, 3784.4512545680996, 3787.9242415151816, 3790.7915064671433, 3791.1848952475075, 3798.563165235978, 5054.292399064134, 5339.599530035224, 5350.010248104113, 5370.2750128732905, 5412.810551630674, 3684.2815650948346, 3713.3316003119157, 3714.86094250358, 3715.4241092630687, 3716.758410703296, 3740.588535261119, 3756.8309426075893, 3761.1725420407465, 3763.2661630982243, 3764.3412402829395, 4284.614384705329, 4287.135096233149, 4306.0, 4308.763018033976, 4315.201687687725, 4964.975175124101, 5047.217681259411, 5095.617828662865, 5106.795728170906, 5111.642185047011, 1342.5166939901628, 1343.368616750126, 1349.284879014124, 1353.7613084028003, 1356.2676154876256, 873.7898011254458, 881.5283823154582, 893.6336102198197, 898.2185498616245, 911.3028533172129, 4543.227651299287, 4553.134904368159, 4554.658400619966, 4555.134524440346, 4556.179887620194, 5221.216817477409, 5225.581953443715, 5225.817096401608, 5233.162693969023, 5259.421463638997, 4390.604845563915, 4497.550244975476, 4544.068465964469, 4547.636189104864, 4556.248219043887, 2750.6974232834373, 2764.1707487753592, 2781.694013658496, 2786.6934637190298, 2795.566687163493, 4860.927086093711, 4865.635077369211, 4876.122297986326, 4895.751583346295, 4900.485449027872, 5135.0, 5319.0, 5333.866653333697, 5347.973260133675, 5386.272853164851, 4887.633427492952, 4907.533784290486, 4911.9754401227765, 4927.852164435073, 4940.580050695731, 5164.0962831505085, 5170.3278573785165, 5181.3782346118705, 5228.189630607262, 5229.555487783429, 4881.51184881509, 5061.077664809802, 5119.897602047864, 5123.820666276662, 5144.922826157685, 4868.294097355934, 4869.634777391639, 4887.780049897834, 4902.509749025069, 4910.9263361050325, 3843.55799083109, 3855.4795102661906, 3856.749311294757, 3857.1514266861245, 3860.6718428933855, 5010.298558201782, 5229.294045303835, 5240.135377662643, 5338.46615338463, 5352.892942141213, 5176.689398636094, 5181.222816577543, 5189.662671926313, 5190.273361729436, 5194.558462530727, 5187.870303242449, 5191.974040129775, 5199.48005199477, 5200.869978250574, 5203.323567936144, 4827.9137194132445, 5106.514881086291, 5107.463716309882, 5127.6410651254055, 5141.871453213699, 4986.576141028053, 5058.3443692061965, 5178.870528236825, 5229.738513074407, 5231.686098834082, 5095.77069031887, 5096.311997880239, 5097.490250974873, 5104.464031276662, 5106.183010718267], "value": 3871.017616080903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.8371149068478, 672.1900110367005, 688.2773088257331, 706.9434445244381, 738.3502517784349, 12944.546940857072, 13644.317784110804, 14133.434662613483, 14150.433982640694, 14610.19643919584, 13232.206067635949, 13284.0, 13418.597442076729, 13419.329033548333, 13436.66408339792, 624.201022690954, 750.5496701978797, 780.7774784186522, 782.6204290918928, 800.8438354520871, 784.6665167303902, 786.1666633368619, 786.4416264452245, 790.8418316336727, 792.2434075457952, 830.8130670599097, 834.1533343656164, 836.6067948064431, 837.0206857976183, 838.0237023867187, 644.4232411991266, 660.5508254387015, 663.2902794010411, 667.2893368562466, 832.50881979632, 586.5219845825638, 599.9730012149464, 602.5179856115091, 603.6438501284264, 603.7615142018922, 13376.732465350737, 13430.261335626537, 13461.192328460324, 13470.730585388237, 13473.595792126252, 12826.166299190523, 13222.491261740068, 13224.0, 13246.139000964906, 13311.933440332834, 11381.317120972768, 11513.539458421654, 11700.707482312926, 11802.0, 11968.581099661556, 3218.243712727507, 3241.4003409369343, 3319.1038419626566, 4119.958800411988, 4195.0, 62042.0, 62995.99999999954, 63232.68383658052, 63761.36238637647, 64164.35835641584, 10440.582376704999, 10484.423356715453, 10528.473576321154, 10558.86680465841, 10578.894211057945, 18457.1694273758, 18490.44528664142, 18512.629747404975, 18534.536636584195, 18570.628587428175, 6645.800625981228, 6691.832704182434, 6755.054292399068, 6777.6272305023695, 6926.8614627708175, 3674.577423596267, 3709.517762690833, 3725.1245957200035, 3731.626837316301, 3768.076821178774, 2954.1728316071535, 3056.786024978275, 3058.990533124064, 3060.4338197433544, 3061.5713800068006, 524.9133892907628, 532.9626926115135, 538.7548665357253, 541.0531569752933, 557.0891592246625, 509.21834983300454, 546.4863028752959, 552.7678375082475, 602.7016626769689, 655.4101308822098, 8206.753797385969, 8652.091530389218, 8691.565421728888, 8693.304535637133, 8726.86909696355, 546.7020473841766, 547.5674217368314, 558.6313033398019, 559.5887023038064, 597.229573849729, 4011.618896204856, 4027.939580906289, 4099.3031184698675, 4244.1723863846255, 4339.652827773833, 93288.0, 94828.52585737166, 95513.5224323874, 98617.0, 98892.50553747329, 81857.0, 84665.0, 84792.15207847842, 84918.15081849226, 87076.0, 48374.516254837705, 50394.49605503898, 60578.697106514184, 76294.61852690812, 76893.23106768973, 7814.6483408247905, 7897.131315555399, 7993.160718124514, 8013.959930200312, 8018.879716804136, 42682.0, 43097.56902431061, 43932.04611584973, 44494.777526112164, 45079.54920450754, 58306.416935831796, 66346.66826665835, 66576.6671166641, 66602.66698666476, 68384.6580767093, 11849.644510664693, 12039.75920481568, 12219.51121955112, 12351.69120771988, 12575.245485270912, 13412.93293533526, 13767.38046787917, 13896.791548126585, 14221.857781422053, 14323.78514322265, 12246.448909798903, 12324.568640097554, 12589.118761686594, 12758.61724148277, 13651.38568764388, 11569.190156689288, 11885.22746021506, 11900.880991189977, 12113.939430302793, 12418.192817466836, 12242.0, 12753.362331883554, 12958.28729419891, 13157.671058223621, 13264.20414775078, 10272.743181420525, 10631.627893023708, 10645.467726613484, 10802.837957430802, 11005.724856878642, 10391.0, 10533.841992370273, 10609.636722301952, 10653.414062226651, 10792.406417646791], "value": 6685.347056091837, "unit": "score"}], "name": "dromaeo_css", "value": 6394.155515593972, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 125.0, 178.0, 123.0, 122.0, 157.0, 124.0, 170.0, 126.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 102.0, 76.0, 75.0, 76.0, 76.0, 98.0, 77.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 119.0, 86.0, 87.0, 85.0, 123.0, 84.0, 85.0, 124.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.6, "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, 97.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 78.0, 81.0, 78.0, 78.0, 84.0, 79.0, 78.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 124.0, 140.0, 135.0, 127.0, 127.0, 127.0, 174.0, 126.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 169.0, 168.0, 164.0, 168.0, 168.0, 170.0, 168.0, 163.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 66.0, 70.0, 71.0, 66.0, 66.0, 65.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1526.4, "alertThreshold": 2.0}]} 07:55:59 INFO - Return code: 0 07:55:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:59 INFO - # TBPL SUCCESS # 07:55:59 INFO - Running post-action listener: _resource_record_post_action 07:55:59 INFO - ##### 07:55:59 INFO - ##### Finished run-tests step (success) 07:55:59 INFO - ##### 07:55:59 INFO - Running post-run listener: _resource_record_post_run 07:56:00 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 533868544; Read time: 0; Write time: 797628 07:56:00 INFO - TinderboxPrint: CPU usage
13.0% 07:56:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:56:00 INFO - TinderboxPrint: I/O write bytes / time
533,868,544 / 797,628 07:56:00 INFO - TinderboxPrint: CPU idle
8,332.7 (87.0%) 07:56:00 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 07:56:00 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:00 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 245731328; Read time: 0; Write time: 423992 07:56:00 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288137216; Read time: 0; Write time: 373636 07:56:00 INFO - Running post-run listener: _upload_blobber_files 07:56:00 INFO - Blob upload gear active. 07:56:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:00 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 07:56:00 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'] 07:56:00 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 07:56:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:01 INFO - (blobuploader) - INFO - Done attempting. 07:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:05 INFO - (blobuploader) - INFO - Done attempting. 07:56:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:06 INFO - (blobuploader) - INFO - Done attempting. 07:56:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:06 INFO - Return code: 0 07:56:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/122113ad936d41b528d00d87d25597de6891674505238d81067968a827349f7a9a6a4b0842e98afaa16fb68c1556ed2ba926dd1a9e9c14eac5bfb07e88db6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e44ebfab11dd5389436b7ce132d93845ff749a768cd2f9861552bd9613ab60315452954ff14cc93765b9ab9990f85c5016408c505aeb0e0600b7ccdce732c6c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd06cde57c0de8c0b1491b48b00a2208c66154b729e588d8471b6853896feb8185cd52594da9b3d2d9a81ccbdce38cd947d43d4c73822bd382bed6ccda8a22fc"} 07:56:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:06 INFO - Contents: 07:56:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/122113ad936d41b528d00d87d25597de6891674505238d81067968a827349f7a9a6a4b0842e98afaa16fb68c1556ed2ba926dd1a9e9c14eac5bfb07e88db6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e44ebfab11dd5389436b7ce132d93845ff749a768cd2f9861552bd9613ab60315452954ff14cc93765b9ab9990f85c5016408c505aeb0e0600b7ccdce732c6c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd06cde57c0de8c0b1491b48b00a2208c66154b729e588d8471b6853896feb8185cd52594da9b3d2d9a81ccbdce38cd947d43d4c73822bd382bed6ccda8a22fc"} 07:56:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:06 INFO - Copying logs to upload dir... 07:56:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.744250 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-06 07:56:05.574104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 07:56:05.577683) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 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/122113ad936d41b528d00d87d25597de6891674505238d81067968a827349f7a9a6a4b0842e98afaa16fb68c1556ed2ba926dd1a9e9c14eac5bfb07e88db6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e44ebfab11dd5389436b7ce132d93845ff749a768cd2f9861552bd9613ab60315452954ff14cc93765b9ab9990f85c5016408c505aeb0e0600b7ccdce732c6c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd06cde57c0de8c0b1491b48b00a2208c66154b729e588d8471b6853896feb8185cd52594da9b3d2d9a81ccbdce38cd947d43d4c73822bd382bed6ccda8a22fc"} build_url:https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/AK0FPYfAQcaAjmAC6cHI4A/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/122113ad936d41b528d00d87d25597de6891674505238d81067968a827349f7a9a6a4b0842e98afaa16fb68c1556ed2ba926dd1a9e9c14eac5bfb07e88db6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e44ebfab11dd5389436b7ce132d93845ff749a768cd2f9861552bd9613ab60315452954ff14cc93765b9ab9990f85c5016408c505aeb0e0600b7ccdce732c6c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd06cde57c0de8c0b1491b48b00a2208c66154b729e588d8471b6853896feb8185cd52594da9b3d2d9a81ccbdce38cd947d43d4c73822bd382bed6ccda8a22fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 07:56:05.603872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:56:05.604207) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467815569.482882-1286355156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 07:56:05.689741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 07:56:05.690332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 07:56:05.690852) ========= ========= Total master_lag: 0.15 =========