builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1467290950.48 results: success (0) buildid: 20160630030207 builduid: 9f989df8752e4e2796a5e3c4faacb2c7 revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.476278) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.476826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.477218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.492435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.492810) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:49:11-- 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% 38.5M=0s 2016-06-30 05:49:11 (38.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.616551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.616884) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.667014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:10.667403) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d700dc054751333e0735f975fce3d3adf153c62a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d700dc054751333e0735f975fce3d3adf153c62a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:49:11,365 truncating revision to first 12 chars 2016-06-30 05:49:11,365 Setting DEBUG logging. 2016-06-30 05:49:11,365 attempt 1/10 2016-06-30 05:49:11,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d700dc054751?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:49:11,686 unpacking tar archive at: mozilla-central-d700dc054751/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:11.382089) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:11.382408) ========= script_repo_revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:11.382799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:11.383072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:49:11.391792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 05:49:11.392145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:12 INFO - MultiFileLogger online at 20160630 05:49:12 in /builds/slave/test 05:49:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:12 INFO - {'append_to_log': False, 05:49:12 INFO - 'base_work_dir': '/builds/slave/test', 05:49:12 INFO - 'blob_upload_branch': 'Firefox', 05:49:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:12 INFO - 'branch': 'Firefox', 05:49:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:12 INFO - 'config_files': ('talos/linux_config.py',), 05:49:12 INFO - 'default_actions': ('clobber', 05:49:12 INFO - 'read-buildbot-config', 05:49:12 INFO - 'download-and-extract', 05:49:12 INFO - 'populate-webroot', 05:49:12 INFO - 'create-virtualenv', 05:49:12 INFO - 'install', 05:49:12 INFO - 'run-tests'), 05:49:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:12 INFO - 'download_minidump_stackwalk': True, 05:49:12 INFO - 'download_symbols': 'ondemand', 05:49:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:12 INFO - 'installer_path': 'installer.exe', 05:49:12 INFO - 'log_level': 'info', 05:49:12 INFO - 'log_name': 'talos', 05:49:12 INFO - 'log_to_console': True, 05:49:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:12 INFO - 'opt_config_files': (), 05:49:12 INFO - 'pip_index': False, 05:49:12 INFO - 'sps_profile': False, 05:49:12 INFO - 'sps_profile_interval': 0, 05:49:12 INFO - 'suite': 'dromaeojs', 05:49:12 INFO - 'system_bits': '32', 05:49:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:12 INFO - 'title': 'talos-linux64-ix-012', 05:49:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:12 INFO - 'use_talos_json': True, 05:49:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:12 INFO - 'work_dir': 'build'} 05:49:12 INFO - ##### 05:49:12 INFO - ##### Running clobber step. 05:49:12 INFO - ##### 05:49:12 INFO - Running pre-action listener: _resource_record_pre_action 05:49:12 INFO - Running main action method: clobber 05:49:12 INFO - rmtree: /builds/slave/test/build 05:49:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:12 INFO - Running post-action listener: _resource_record_post_action 05:49:12 INFO - ##### 05:49:12 INFO - ##### Finished clobber step (success) 05:49:12 INFO - ##### 05:49:12 INFO - ##### 05:49:12 INFO - ##### Running read-buildbot-config step. 05:49:12 INFO - ##### 05:49:12 INFO - Running pre-action listener: _resource_record_pre_action 05:49:12 INFO - Running main action method: read_buildbot_config 05:49:12 INFO - Using buildbot properties: 05:49:12 INFO - { 05:49:12 INFO - "project": "", 05:49:12 INFO - "product": "firefox", 05:49:12 INFO - "script_repo_revision": "production", 05:49:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:49:12 INFO - "repository": "", 05:49:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:49:12 INFO - "buildid": "20160630030207", 05:49:12 INFO - "stage_platform": "linux64-pgo", 05:49:12 INFO - "basedir": "/builds/slave/test", 05:49:12 INFO - "nightly_build": "True", 05:49:12 INFO - "buildnumber": 794, 05:49:12 INFO - "slavename": "talos-linux64-ix-012", 05:49:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:49:12 INFO - "platform": "ubuntu64_hw", 05:49:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:12 INFO - "branch": "mozilla-central", 05:49:12 INFO - "repo_path": "mozilla-central", 05:49:12 INFO - "revision": "d700dc054751333e0735f975fce3d3adf153c62a", 05:49:12 INFO - "pgo_build": "True", 05:49:12 INFO - "builduid": "9f989df8752e4e2796a5e3c4faacb2c7", 05:49:12 INFO - "slavebuilddir": "test" 05:49:12 INFO - } 05:49:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:49:12 INFO - Running post-action listener: _resource_record_post_action 05:49:12 INFO - ##### 05:49:12 INFO - ##### Finished read-buildbot-config step (success) 05:49:12 INFO - ##### 05:49:12 INFO - ##### 05:49:12 INFO - ##### Running download-and-extract step. 05:49:12 INFO - ##### 05:49:12 INFO - Running pre-action listener: _resource_record_pre_action 05:49:12 INFO - Running main action method: download_and_extract 05:49:12 INFO - mkdir: /builds/slave/test/build/tests 05:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:12 INFO - https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:49:13 INFO - Downloaded 1361 bytes. 05:49:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:13 INFO - Using the following test package requirements: 05:49:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'jsshell-linux-x86_64.zip'], 05:49:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:13 INFO - https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:15 INFO - Downloaded 24268131 bytes. 05:49:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:17 INFO - Return code: 0 05:49:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:17 INFO - https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:18 INFO - Downloaded 24268131 bytes. 05:49:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:19 INFO - Return code: 0 05:49: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')]} 05:49:19 INFO - https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:22 INFO - Downloaded 14405245 bytes. 05:49:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:22 INFO - Return code: 0 05:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:22 INFO - https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:23 INFO - Downloaded 60339825 bytes. 05:49:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:23 INFO - mkdir: /builds/slave/test/properties 05:49:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:23 INFO - Contents: 05:49:23 INFO - build_url:https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:24 INFO - Running post-action listener: _resource_record_post_action 05:49:24 INFO - Running post-action listener: set_extra_try_arguments 05:49:24 INFO - ##### 05:49:24 INFO - ##### Finished download-and-extract step (success) 05:49:24 INFO - ##### 05:49:24 INFO - ##### 05:49:24 INFO - ##### Running populate-webroot step. 05:49:24 INFO - ##### 05:49:24 INFO - Running pre-action listener: _resource_record_pre_action 05:49:24 INFO - Running main action method: populate_webroot 05:49:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:24 INFO - '--tppagecycles', 05:49:24 INFO - '7'], 05:49:24 INFO - 'tests': ['tsvgm']}}, 05:49:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['damp', 'tps']}, 05:49:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['damp', 'tps']}, 05:49:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['dromaeo_dom']}, 05:49:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['basic_compositor_video']}, 05:49:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tsvgx', 05:49:24 INFO - 'tsvgr_opacity', 05:49:24 INFO - 'tart', 05:49:24 INFO - 'tscrollx', 05:49:24 INFO - 'cart']}, 05:49:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:24 INFO - 'tsvgr_opacity', 05:49:24 INFO - 'tart', 05:49:24 INFO - 'tscrollx', 05:49:24 INFO - 'cart']}, 05:49:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tp5o']}, 05:49:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['tp5o']}, 05:49:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s', 05:49:24 INFO - '--xperf_path', 05:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:24 INFO - 'tests': ['tp5n']}, 05:49:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--xperf_path', 05:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:24 INFO - 'tests': ['tp5n']}}, 05:49:24 INFO - 'talos.zip': {'path': '', 05:49:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:24 INFO - Running post-action listener: _resource_record_post_action 05:49:24 INFO - ##### 05:49:24 INFO - ##### Finished populate-webroot step (success) 05:49:24 INFO - ##### 05:49:24 INFO - ##### 05:49:24 INFO - ##### Running create-virtualenv step. 05:49:24 INFO - ##### 05:49:24 INFO - Running pre-action listener: _resource_record_pre_action 05:49:24 INFO - Running main action method: create_virtualenv 05:49:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:24 INFO - Using real prefix '/usr' 05:49:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:27 INFO - Installing pip.................done. 05:49:27 INFO - Return code: 0 05:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:27 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:27 INFO - Using env: {'DISPLAY': ':0', 05:49:27 INFO - 'HOME': '/home/cltbld', 05:49:27 INFO - 'LANG': 'en_US.UTF-8', 05:49:27 INFO - 'LANGUAGE': 'en_US:en', 05:49:27 INFO - 'LOGNAME': 'cltbld', 05:49:27 INFO - 'MAIL': '/var/mail/cltbld', 05:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:27 INFO - 'MOZ_NO_REMOTE': '1', 05:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:27 INFO - 'NO_EM_RESTART': '1', 05:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:27 INFO - 'PWD': '/builds/slave/test', 05:49:27 INFO - 'SHELL': '/bin/bash', 05:49:27 INFO - 'SHLVL': '1', 05:49:27 INFO - 'TERM': 'linux', 05:49:27 INFO - 'TMOUT': '86400', 05:49:27 INFO - 'USER': 'cltbld', 05:49:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:27 INFO - '_': '/tools/buildbot/bin/python'} 05:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:27 INFO - Cleaning up... 05:49:27 INFO - Return code: 0 05:49:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:27 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:27 INFO - Using env: {'DISPLAY': ':0', 05:49:27 INFO - 'HOME': '/home/cltbld', 05:49:27 INFO - 'LANG': 'en_US.UTF-8', 05:49:27 INFO - 'LANGUAGE': 'en_US:en', 05:49:27 INFO - 'LOGNAME': 'cltbld', 05:49:27 INFO - 'MAIL': '/var/mail/cltbld', 05:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:27 INFO - 'MOZ_NO_REMOTE': '1', 05:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:27 INFO - 'NO_EM_RESTART': '1', 05:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:27 INFO - 'PWD': '/builds/slave/test', 05:49:27 INFO - 'SHELL': '/bin/bash', 05:49:27 INFO - 'SHLVL': '1', 05:49:27 INFO - 'TERM': 'linux', 05:49:27 INFO - 'TMOUT': '86400', 05:49:27 INFO - 'USER': 'cltbld', 05:49:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:27 INFO - '_': '/tools/buildbot/bin/python'} 05:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:27 INFO - Downloading/unpacking psutil>=3.1.1 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:29 INFO - Installing collected packages: psutil 05:49:29 INFO - Running setup.py install for psutil 05:49:29 INFO - building 'psutil._psutil_linux' extension 05:49:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:29 INFO - building 'psutil._psutil_posix' extension 05:49:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:30 INFO - Successfully installed psutil 05:49:30 INFO - Cleaning up... 05:49:30 INFO - Return code: 0 05:49:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:30 INFO - Using env: {'DISPLAY': ':0', 05:49:30 INFO - 'HOME': '/home/cltbld', 05:49:30 INFO - 'LANG': 'en_US.UTF-8', 05:49:30 INFO - 'LANGUAGE': 'en_US:en', 05:49:30 INFO - 'LOGNAME': 'cltbld', 05:49:30 INFO - 'MAIL': '/var/mail/cltbld', 05:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:30 INFO - 'MOZ_NO_REMOTE': '1', 05:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:30 INFO - 'NO_EM_RESTART': '1', 05:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:30 INFO - 'PWD': '/builds/slave/test', 05:49:30 INFO - 'SHELL': '/bin/bash', 05:49:30 INFO - 'SHLVL': '1', 05:49:30 INFO - 'TERM': 'linux', 05:49:30 INFO - 'TMOUT': '86400', 05:49:30 INFO - 'USER': 'cltbld', 05:49:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:30 INFO - '_': '/tools/buildbot/bin/python'} 05:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:32 INFO - Installing collected packages: mozsystemmonitor 05:49:32 INFO - Running setup.py install for mozsystemmonitor 05:49:32 INFO - Successfully installed mozsystemmonitor 05:49:32 INFO - Cleaning up... 05:49:32 INFO - Return code: 0 05:49:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:49:32 INFO - Using env: {'DISPLAY': ':0', 05:49:32 INFO - 'HOME': '/home/cltbld', 05:49:32 INFO - 'LANG': 'en_US.UTF-8', 05:49:32 INFO - 'LANGUAGE': 'en_US:en', 05:49:32 INFO - 'LOGNAME': 'cltbld', 05:49:32 INFO - 'MAIL': '/var/mail/cltbld', 05:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:32 INFO - 'MOZ_NO_REMOTE': '1', 05:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:32 INFO - 'NO_EM_RESTART': '1', 05:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:32 INFO - 'PWD': '/builds/slave/test', 05:49:32 INFO - 'SHELL': '/bin/bash', 05:49:32 INFO - 'SHLVL': '1', 05:49:32 INFO - 'TERM': 'linux', 05:49:32 INFO - 'TMOUT': '86400', 05:49:32 INFO - 'USER': 'cltbld', 05:49:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:32 INFO - '_': '/tools/buildbot/bin/python'} 05:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:32 INFO - Downloading/unpacking jsonschema==2.5.1 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:34 INFO - warning: no files found matching '*.txt' 05:49:34 INFO - no previously-included directories found matching 'build' 05:49:34 INFO - no previously-included directories found matching 'dist' 05:49:34 INFO - no previously-included directories found matching '.git*' 05:49:34 INFO - Installing collected packages: jsonschema, functools32 05:49:34 INFO - Running setup.py install for functools32 05:49:34 INFO - warning: no files found matching '*.txt' 05:49:34 INFO - no previously-included directories found matching 'build' 05:49:34 INFO - no previously-included directories found matching 'dist' 05:49:34 INFO - no previously-included directories found matching '.git*' 05:49:34 INFO - Successfully installed jsonschema functools32 05:49:34 INFO - Cleaning up... 05:49:34 INFO - Return code: 0 05:49:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:34 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:34 INFO - Using env: {'DISPLAY': ':0', 05:49:34 INFO - 'HOME': '/home/cltbld', 05:49:34 INFO - 'LANG': 'en_US.UTF-8', 05:49:34 INFO - 'LANGUAGE': 'en_US:en', 05:49:34 INFO - 'LOGNAME': 'cltbld', 05:49:34 INFO - 'MAIL': '/var/mail/cltbld', 05:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:34 INFO - 'MOZ_NO_REMOTE': '1', 05:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:34 INFO - 'NO_EM_RESTART': '1', 05:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:34 INFO - 'PWD': '/builds/slave/test', 05:49:34 INFO - 'SHELL': '/bin/bash', 05:49:34 INFO - 'SHLVL': '1', 05:49:34 INFO - 'TERM': 'linux', 05:49:34 INFO - 'TMOUT': '86400', 05:49:34 INFO - 'USER': 'cltbld', 05:49:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:34 INFO - '_': '/tools/buildbot/bin/python'} 05:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:37 INFO - Downloading docopt-0.6.1.tar.gz 05:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:37 INFO - Running setup.py install for blobuploader 05:49:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:37 INFO - Running setup.py install for requests 05:49:38 INFO - Running setup.py install for docopt 05:49:38 INFO - Successfully installed blobuploader requests docopt 05:49:38 INFO - Cleaning up... 05:49:38 INFO - Return code: 0 05:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:38 INFO - Using env: {'DISPLAY': ':0', 05:49:38 INFO - 'HOME': '/home/cltbld', 05:49:38 INFO - 'LANG': 'en_US.UTF-8', 05:49:38 INFO - 'LANGUAGE': 'en_US:en', 05:49:38 INFO - 'LOGNAME': 'cltbld', 05:49:38 INFO - 'MAIL': '/var/mail/cltbld', 05:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:38 INFO - 'MOZ_NO_REMOTE': '1', 05:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:38 INFO - 'NO_EM_RESTART': '1', 05:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:38 INFO - 'PWD': '/builds/slave/test', 05:49:38 INFO - 'SHELL': '/bin/bash', 05:49:38 INFO - 'SHLVL': '1', 05:49:38 INFO - 'TERM': 'linux', 05:49:38 INFO - 'TMOUT': '86400', 05:49:38 INFO - 'USER': 'cltbld', 05:49:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:38 INFO - '_': '/tools/buildbot/bin/python'} 05:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:38 INFO - Running setup.py (path:/tmp/pip-NjR7UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:38 INFO - Running setup.py (path:/tmp/pip-1eIgyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:38 INFO - Running setup.py (path:/tmp/pip-kmncAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:38 INFO - Running setup.py (path:/tmp/pip-WWiNUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:38 INFO - Running setup.py (path:/tmp/pip-ROtIIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:39 INFO - Running setup.py (path:/tmp/pip-Z1CcpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:39 INFO - Running setup.py (path:/tmp/pip-azyprc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:39 INFO - Running setup.py (path:/tmp/pip-AUPYYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:39 INFO - Running setup.py (path:/tmp/pip-BXHjMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:39 INFO - Running setup.py (path:/tmp/pip-fP9iyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:39 INFO - Running setup.py (path:/tmp/pip-52YXYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:39 INFO - Running setup.py (path:/tmp/pip-FM9YGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:39 INFO - Running setup.py (path:/tmp/pip-5IsR8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:39 INFO - Running setup.py (path:/tmp/pip-W0J0VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:39 INFO - Running setup.py (path:/tmp/pip-4yxBgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:39 INFO - Running setup.py (path:/tmp/pip-0LTCij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:39 INFO - Running setup.py (path:/tmp/pip-XsXQQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:39 INFO - Running setup.py install for manifestparser 05:49:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:39 INFO - Running setup.py install for mozcrash 05:49:40 INFO - Running setup.py install for mozdebug 05:49:40 INFO - Running setup.py install for mozdevice 05:49:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Running setup.py install for mozfile 05:49:40 INFO - Running setup.py install for mozhttpd 05:49:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Running setup.py install for mozinfo 05:49:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Running setup.py install for mozInstall 05:49:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Running setup.py install for mozleak 05:49:40 INFO - Running setup.py install for mozlog 05:49:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:40 INFO - Running setup.py install for moznetwork 05:49:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Running setup.py install for mozprocess 05:49:41 INFO - Running setup.py install for mozprofile 05:49:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Running setup.py install for mozrunner 05:49:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Running setup.py install for mozscreenshot 05:49:41 INFO - Running setup.py install for moztest 05:49:41 INFO - Running setup.py install for mozversion 05:49:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:41 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:41 INFO - Running setup.py (path:/tmp/pip-RFZvIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:41 INFO - Running setup.py (path:/tmp/pip-VNShvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:42 INFO - Running setup.py (path:/tmp/pip-hBE2Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:42 INFO - Running setup.py (path:/tmp/pip-vMNKdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:42 INFO - Running setup.py (path:/tmp/pip-5JtFyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:42 INFO - Running setup.py (path:/tmp/pip-gduldW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:42 INFO - Running setup.py (path:/tmp/pip-km8LiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:42 INFO - Running setup.py (path:/tmp/pip-4DyoPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:42 INFO - Running setup.py (path:/tmp/pip-9CfHvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:42 INFO - Running setup.py (path:/tmp/pip-CG7500-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:42 INFO - Running setup.py (path:/tmp/pip-ieFcOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:42 INFO - Running setup.py (path:/tmp/pip-AxPdGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:42 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)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:42 INFO - Running setup.py (path:/tmp/pip-50uGDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:42 INFO - Running setup.py (path:/tmp/pip-NlFvF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:42 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)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:42 INFO - Running setup.py (path:/tmp/pip-pMo3jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:42 INFO - Running setup.py (path:/tmp/pip-PfOFsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:43 INFO - Running setup.py (path:/tmp/pip-0tLzGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:45 INFO - Downloading blessings-1.6.tar.gz 05:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:45 INFO - Installing collected packages: blessings 05:49:45 INFO - Running setup.py install for blessings 05:49:45 INFO - Successfully installed blessings 05:49:45 INFO - Cleaning up... 05:49:45 INFO - Return code: 0 05:49:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:45 INFO - Reading from file tmpfile_stdout 05:49:45 INFO - Current package versions: 05:49:45 INFO - argparse == 1.2.1 05:49:45 INFO - blessings == 1.6 05:49:45 INFO - blobuploader == 1.2.4 05:49:45 INFO - docopt == 0.6.1 05:49:45 INFO - functools32 == 3.2.3-2 05:49:45 INFO - jsonschema == 2.5.1 05:49:45 INFO - manifestparser == 1.1 05:49:45 INFO - mozInstall == 1.12 05:49:45 INFO - mozcrash == 0.17 05:49:45 INFO - mozdebug == 0.1 05:49:45 INFO - mozdevice == 0.48 05:49:45 INFO - mozfile == 1.2 05:49:45 INFO - mozhttpd == 0.7 05:49:45 INFO - mozinfo == 0.9 05:49:45 INFO - mozleak == 0.1 05:49:45 INFO - mozlog == 3.2 05:49:45 INFO - moznetwork == 0.27 05:49:45 INFO - mozprocess == 0.22 05:49:45 INFO - mozprofile == 0.28 05:49:45 INFO - mozrunner == 6.11 05:49:45 INFO - mozscreenshot == 0.1 05:49:45 INFO - mozsystemmonitor == 0.3 05:49:45 INFO - moztest == 0.7 05:49:45 INFO - mozversion == 1.4 05:49:45 INFO - psutil == 3.1.1 05:49:45 INFO - requests == 1.2.3 05:49:45 INFO - wsgiref == 0.1.2 05:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 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 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:45 INFO - Using env: {'DISPLAY': ':0', 05:49:45 INFO - 'HOME': '/home/cltbld', 05:49:45 INFO - 'LANG': 'en_US.UTF-8', 05:49:45 INFO - 'LANGUAGE': 'en_US:en', 05:49:45 INFO - 'LOGNAME': 'cltbld', 05:49:45 INFO - 'MAIL': '/var/mail/cltbld', 05:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:45 INFO - 'MOZ_NO_REMOTE': '1', 05:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:45 INFO - 'NO_EM_RESTART': '1', 05:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:45 INFO - 'PWD': '/builds/slave/test', 05:49:45 INFO - 'SHELL': '/bin/bash', 05:49:45 INFO - 'SHLVL': '1', 05:49:45 INFO - 'TERM': 'linux', 05:49:45 INFO - 'TMOUT': '86400', 05:49:45 INFO - 'USER': 'cltbld', 05:49:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:45 INFO - '_': '/tools/buildbot/bin/python'} 05:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:45 INFO - Cleaning up... 05:49:45 INFO - Return code: 0 05:49:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:49:45 INFO - Using env: {'DISPLAY': ':0', 05:49:45 INFO - 'HOME': '/home/cltbld', 05:49:45 INFO - 'LANG': 'en_US.UTF-8', 05:49:45 INFO - 'LANGUAGE': 'en_US:en', 05:49:45 INFO - 'LOGNAME': 'cltbld', 05:49:45 INFO - 'MAIL': '/var/mail/cltbld', 05:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:45 INFO - 'MOZ_NO_REMOTE': '1', 05:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:45 INFO - 'NO_EM_RESTART': '1', 05:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:45 INFO - 'PWD': '/builds/slave/test', 05:49:45 INFO - 'SHELL': '/bin/bash', 05:49:45 INFO - 'SHLVL': '1', 05:49:45 INFO - 'TERM': 'linux', 05:49:45 INFO - 'TMOUT': '86400', 05:49:45 INFO - 'USER': 'cltbld', 05:49:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:45 INFO - '_': '/tools/buildbot/bin/python'} 05:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:45 INFO - Cleaning up... 05:49:45 INFO - Return code: 0 05:49:45 INFO - Running post-action listener: _resource_record_post_action 05:49:45 INFO - Running post-action listener: _start_resource_monitoring 05:49:45 INFO - Starting resource monitoring. 05:49:45 INFO - ##### 05:49:45 INFO - ##### Finished create-virtualenv step (success) 05:49:45 INFO - ##### 05:49:45 INFO - ##### 05:49:45 INFO - ##### Running install step. 05:49:45 INFO - ##### 05:49:45 INFO - Running pre-action listener: _resource_record_pre_action 05:49:45 INFO - Running main action method: install 05:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:46 INFO - Reading from file tmpfile_stdout 05:49:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:46 INFO - Reading from file tmpfile_stdout 05:49:46 INFO - Output received: 05:49:46 INFO - Usage: mozinstall [options] installer 05:49:46 INFO - Options: 05:49:46 INFO - -h, --help show this help message and exit 05:49:46 INFO - -d DEST, --destination=DEST 05:49:46 INFO - Directory to install application into. [default: 05:49:46 INFO - "/builds/slave/test"] 05:49:46 INFO - --app=APP Application being installed. [default: firefox] 05:49:46 INFO - mkdir: /builds/slave/test/build/application 05:49:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:50:03 INFO - Reading from file tmpfile_stdout 05:50:03 INFO - Output received: 05:50:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:50:03 INFO - Running post-action listener: _resource_record_post_action 05:50:03 INFO - ##### 05:50:03 INFO - ##### Finished install step (success) 05:50:03 INFO - ##### 05:50:03 INFO - ##### 05:50:03 INFO - ##### Running run-tests step. 05:50:03 INFO - ##### 05:50:03 INFO - Running pre-action listener: _resource_record_pre_action 05:50:03 INFO - Running main action method: run_tests 05:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:03 INFO - Python 2.7.3 05:50:03 INFO - Return code: 0 05:50:03 INFO - grabbing minidump binary from tooltool 05:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:03 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 0x2baa3b0>, '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 0x2bab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bab740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:50:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:50:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:50:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:03 INFO - Return code: 0 05:50:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:50:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:50:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:50:03 INFO - Using env: {'DISPLAY': ':0', 05:50:03 INFO - 'HOME': '/home/cltbld', 05:50:03 INFO - 'LANG': 'en_US.UTF-8', 05:50:03 INFO - 'LANGUAGE': 'en_US:en', 05:50:03 INFO - 'LOGNAME': 'cltbld', 05:50:03 INFO - 'MAIL': '/var/mail/cltbld', 05:50:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:03 INFO - 'MOZ_NO_REMOTE': '1', 05:50:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:03 INFO - 'NO_EM_RESTART': '1', 05:50:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:03 INFO - 'PWD': '/builds/slave/test', 05:50:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:03 INFO - 'SHELL': '/bin/bash', 05:50:03 INFO - 'SHLVL': '1', 05:50:03 INFO - 'TERM': 'linux', 05:50:03 INFO - 'TMOUT': '86400', 05:50:03 INFO - 'USER': 'cltbld', 05:50:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255', 05:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:03 INFO - '_': '/tools/buildbot/bin/python'} 05:50:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:50:03 INFO - mozversion application_buildid: 20160630030207 05:50:03 INFO - mozversion application_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:50:03 INFO - mozversion application_display_name: Nightly 05:50:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:03 INFO - mozversion application_name: Firefox 05:50:03 INFO - mozversion application_remotingname: firefox 05:50:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:03 INFO - mozversion application_vendor: Mozilla 05:50:03 INFO - mozversion application_version: 50.0a1 05:50:03 INFO - mozversion platform_buildid: 20160630030207 05:50:03 INFO - mozversion platform_changeset: d700dc054751333e0735f975fce3d3adf153c62a 05:50:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:03 INFO - mozversion platform_version: 50.0a1 05:50:03 INFO - using testdate: 1467291003 05:50:03 INFO - actual date: 1467291003 05:50:03 INFO - starting webserver on 'localhost:33738' 05:50:03 INFO - SUITE-START | Running 2 tests 05:50:03 INFO - TEST-START | dromaeo_css 05:50:03 INFO - operating with platform_type : linux_ 05:50:03 INFO - Initialising browser for dromaeo_css test... 05:50:03 INFO - TEST-INFO | started process 30865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJdHqX/profile http://localhost:33738/getInfo.html) 05:50:07 INFO - PROCESS | 30865 | __metrics Screen width/height:1600/1200 05:50:07 INFO - PROCESS | 30865 | colorDepth:24 05:50:07 INFO - PROCESS | 30865 | Browser inner width/height: 1024/697 05:50:07 INFO - PROCESS | 30865 | __metrics 05:50:08 INFO - PROCESS | 30865 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:09 INFO - TEST-INFO | 30865: exit 0 05:50:09 INFO - Browser initialized. 05:50:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:09 INFO - TEST-INFO | started process 30946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJdHqX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:20 INFO - PROCESS | 30946 | RSS: Main: 157036544 05:50:20 INFO - PROCESS | 30946 | 05:51:11 INFO - PROCESS | 30946 | 1467291071549 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:53:20 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33738/tests/dromaeo/cssquery-ext.html) 05:53:21 INFO - PROCESS | 30946 | RSS: Main: 253865984 05:53:21 INFO - PROCESS | 30946 | 05:56:24 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-ext.html (next: http://localhost:33738/tests/dromaeo/cssquery-jquery.html) 05:56:24 INFO - PROCESS | 30946 | RSS: Main: 242864128 05:56:24 INFO - PROCESS | 30946 | 05:59:26 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33738/tests/dromaeo/cssquery-mootools.html) 05:59:27 INFO - PROCESS | 30946 | RSS: Main: 237953024 05:59:27 INFO - PROCESS | 30946 | 06:02:29 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33738/tests/dromaeo/cssquery-prototype.html) 06:02:29 INFO - PROCESS | 30946 | RSS: Main: 244281344 06:02:29 INFO - PROCESS | 30946 | 06:05:32 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33738/tests/dromaeo/cssquery-yui.html) 06:05:33 INFO - PROCESS | 30946 | RSS: Main: 225910784 06:05:33 INFO - PROCESS | 30946 | 06:08:35 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:33738/tests/dromaeo/cssquery-yui.html (next: http://localhost:33738/tests/dromaeo/cssquery-dojo.html) 06:08:36 INFO - PROCESS | 30946 | RSS: Main: 312737792 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | __start_tp_report 06:08:36 INFO - PROCESS | 30946 | _x_x_mozilla_page_load 06:08:36 INFO - PROCESS | 30946 | _x_x_mozilla_page_load_details 06:08:36 INFO - PROCESS | 30946 | |i|pagename|runs| 06:08:36 INFO - PROCESS | 30946 | |0;dojo.html;3132.232603012262;3137.545055966885;3168.2396224906024;3171.3815805917857;3201.6318123415813;5234.057869583474;5283.181106928422;5444.346678398593;5524.972375138123;5564.415736347681;5402.37872644646;5407.810726624569;5539.390667026634;5583.190437386586;5637.46444087811;4943.184374578191;4964.826231081913;4973.825916092937;4977.900441991158;5135.691858488484;5016.974915125419;5039.874003149914;5088.669236499634;5103.719295438749;5109.105906466372;4869.756512174377;4882.145624515695;4940.876478088041;4964.453910069889;5037.697738135724;4845.27320901864;4849.75751212438;4857.587105096036;4908.141075311842;4945.9258111128365;4897.730624815634;4916.950830491721;4924.1875090610365;4932.186189278765;4935.0376676548085;5270.077736396115;5363.061464243741;5492.313460817398;5495.2856128703015;5569.749361278752;5786.421357864222;5802.88394232113;5805.941940580582;5823.941760582382;5836.270466191726;5802.622829516068;5839.0949402842625;5879.588428809985;5892.823215303548;5895.35151133375;5472.616916815825;5508.834734957958;5519.39286678465;5619.072852979212;5625.268715067015;6084.026555751058;6085.5435842312;6087.164846573107;6122.387761223842;6135.355787642323;5594.636348637326;5635.6618602883955;5836.2412886325355;5887.470127688529;5893.528517718572;5762.9135562966585;5882.147088672119;5882.294124704978;5883.294004719461;5887.970560147171;5739.253896993364;5774.913376299359;5786.334571524244;5797.884042319214;5805.94194058054;5658.264425624725;5729.083346664514;5768.451997060272;5790.189373487715;5792.362840087587;4448.5773851484055;4453.309736990772;4457.977710111493;4495.213337665896;4495.483019452739;3969.226000929791;3976.1252524444576;3977.960220397817;3984.780837053932;4015.7389769665465;5463.207834864002;5517.5585953123655;5524.696141712164;5577.776888924479;5585.413531579125;5897.174395584621;5912.40875912414;5918.526517878559;5924.11138329254;5952.553558483044;5645.096784514458;5652.349979752299;5655.4344565543115;5658.943410565842;5659.660420374791;4770.856874293708;4816.373871396696;4842.467328593852;4855.36880205571;4906.533879281463;6072.635641861591;6073.75704971805;6077.969610151921;6078.787242446493;6080;5847.327557330791;5862.355140934579;5866.2960444746905;5869.559783016205;5874.618149820248;5873.148393483007;6007.948608993322;6052.606580572248;6066.636001839904;6136.140940268455;5776.306843178677;5810;5815;5818.069108942549;5829.3296270927685;5665.405132461197;5893.174955506318;5903.822885313448;5908.734106965283;5909.763609455746;5627.8593035174445;5640.548756099584;5665.688387138747;5726.0838265877255;5731.054376027909;5639.971800140973;5701.600887937804;5707.600467967202;5709.200711900255;5713.257276554187;5510.834674959758;5552.500274975271;5635.464630860061;5636.436356364331;5643.407442218672;5692.174634678031;5750.108733146369;5756.107803290497;5818.7090645466715;5825.271841019872;5594.104943209067;5619.775208991595;5622.465865742748;5624.859378515406;5626.746796394254 06:08:36 INFO - PROCESS | 30946 | |1;ext.html;581.2124571206016;609.1897775957975;622.9876450767503;626.6490765171504;629.8299459146028;33109.17227069324;36125.27749445013;36136;36227.456588151195;43301.78349108258;41745.373819392735;45461.545384546145;45494.77252613741;45516.3172552412;45524.317135243;8937.910620893788;9125;9132.543372831331;9132.863007054899;9138;8961.910380896174;9062.320325975545;9067.274618030575;9068.183863452288;9070.183683468487;9024.909750902505;9095.954520227422;9100.271978241724;9105.135012173865;9105.63577456901;9027.638894444215;9027.819443611124;9070.002299747022;9086.136817002407;9088.727338179866;8973.416727912665;9037.502937338444;9041.3671043027;9043.638254469814;9047.095290470967;43828.34257486108;44113.558864411265;44210.77894610538;44216;44288.3356749649;3516.314318707853;3678.0437086357474;3688.926221475582;3689.538807649044;3706.9629303707156;32613.51079733806;33097.48819942719;33244.3351132976;33434.331313373594;34005;4429.822807087713;4485.573870482299;4565.292379681122;4584.243599806028;4645.698029628097;334292;337362;337818;339104;339802;53182.73408632932;53466;53676.46323536715;53724.462755372726;53797.462025379245;39823.601763982566;40737;40773.59226407698;40793;40815.387769183486;16280.511584652479;16363.91818040926;16365.345386184657;16370;16382.508524744277;12949.287789171498;13055.543055992996;13060.477580896848;13086;13107;19539.316123935594;19600;19673.606527869364;19778.30775922836;19892.90053549752;7016.7193312267955;7019.3682568569075;7189.856202875913;7201.207867134611;7332.560046397233;850.46420754924;945.1965829045256;954.6181527388961;964.243069190696;1092.6230450494568;25904.481910361686;26196.73803261981;26225.213243602724;26349.077782277527;26624.8668756655;1049.1187402581716;1052.489542571852;1056.2025670618634;1068.3056013591229;1112.8163852964333;13162;13184;13198.340082996005;13473.932630336785;13647.181169129884;531899;534176;536851;538097.6426767929;540361;60081.69959150176;60631.09053364203;60664;60693.39306606966;60741.392586073576;1252.2549083295426;1280.4686055287139;1364.0724307470816;1381.5579014715395;1393.3590548347875;24613.63079553844;25961;26260;26300;26501.469970600865;51485.7425712869;51900.480995189566;52107.21839172491;52109.47890521046;52137.7393113032;396488.08779780735;399243;399375;399494;400860;25029.249122526355;25871.741282586932;29253.41493170167;29357.85321073381;31099.37801243917;49324;49715.254271186684;49889.25166122583;49893.75053124711;50188.49811501838;41041;41243.08717268566;42135.36796947987;42694.14611707686;43011;42089.36865946952;44437.55562444334;45938;46711.76644116758;47264;41103.38344924769;42632.78683606562;42889.63436086145;44330.335044973704;45782.771086144356;38086.80956595199;38606;39376;39906;40448.19103617852;28221.858890705415;28247.43505129927;28369.432611347245;28502.91297880025;28555 06:08:36 INFO - PROCESS | 30946 | |2;jquery.html;396.9404589311601;399.24941110711876;410.6160739708373;416.29853696521366;424.30202317188224;15782.763258551116;19538.316158934405;19761.209551617936;19891.70162447561;20101.195952161932;19402.805971940277;19700.70448943267;19791.5052123697;20025.299114530993;20048.1980720771;5837.766489340422;6044;6342.904856427157;6852.760153394632;6861.382475577197;6536.117624120754;6825.556338837984;6827.180738311409;6850.280720524348;6899.6550172491425;6749.392554670078;6775.62734049627;6779.0509328694025;6789.966050169767;6795.456363490934;5614.775408983656;5893.5579831512805;5897.587168898179;6746.426553742913;6753.527253092286;5678.545716342683;5679.858003549903;5681.119426488859;5694.459026392527;5700.030994730906;19676.70484942727;22572.774272257233;22894.77105228943;23636.881815590983;24138;2312.410335364488;2384.094044263169;2467.543504451682;2483.950320993588;2580.8967641294325;10547.84178237327;10670.413127277996;10867.510962006729;11043;11290.379029153393;1899.5536049028467;1936.1674479973606;1963.7741659709172;1985.5397656444777;2005.2780998840406;82142.58928705378;87491.56254218752;87757;88287.0541651248;90554;10968.945155274332;11148.609798657008;11435.655690583577;11680.70798230051;11762.294262344287;16216.432424865308;16270.83729162717;16340.346386144658;16376.918115409348;16414.09722465252;8335.54154521495;8413;8497.702580409656;8565.914340856636;8721.520316382659;7921.683132674743;7966.402519811038;8040.2361775631225;8068.314193293636;8334.874976875351;4929.693631187738;5023.196288593807;5042.647014708935;5119.283300337956;5157.793688252503;1962.607478504305;1982.3656429942569;1994.5711671990302;2069.1413063578448;2073.139647046459;936.9531523423801;965.5799727118725;975.3903810118676;1024.1806554756315;1077.7952189084206;18697.15862786178;19284.939328337077;19514.414567562995;19597.608047838963;19808.33209196093;952.1620973543376;974.848898420746;1020.7907378987289;1044.754482696581;1063.4310643805527;10266.845997310047;10907.34555926631;10974.945125274482;11024.779504409868;11026.669199924016;476305;480035;482198;483235;485538;91376.54311728399;93459;95305;96450;97583;994.6667866264737;994.6916455898695;1017.399734156851;1017.6590842067842;1023.8822535408524;17251.568710782332;17386;17693.55766105806;17737.911310443364;17824.197911093772;45720.54279457296;46015.76992115018;46477.3028404581;46721;47014;61162.38837611567;61328.38671613227;61356.386436135064;63217;63536.36463635489;7926.326262267772;7983.72056978003;8346.707865224687;8634.697785577475;9033.187013168847;11790.469428875549;13460.192388456724;13526.323683815966;13996.65008374758;14096.154230746188;11715.707107322385;11874.406279685809;11887.28676279426;12237.632871013884;12290.692732681755;11122.777544449227;11750.764984700429;11929.701757456132;12269.631911042683;12442;12022.879771202175;12450.377481125726;12454.564090256797;12582.559610413591;12624.621261362174;9027.14242146995;9122.726318210463;9164.495952722664;9272.490013049348;9373.718788436357;9504.287178461505;11953.581624643095;11966.64100076999;12229.205101668364;12254.693632659255 06:08:36 INFO - PROCESS | 30946 | |3;mootools.html;1365.0649305225927;1477.5198060630294;1520.3766455753141;1675.3968571314333;1806.9819301806986;8480.703175388862;8865.379423440354;8873.068327825582;8881.245094166996;9059.094090590937;8274.751757447271;8547.615357308921;8825.735227943156;8839.160279773427;8840.027596964344;2063.071617772001;2137.690034944932;2138.9893050534724;2398.8920498577563;2454.6686197363397;2363.9645405318934;2461.064795377763;2471.4315707387314;2481.2308184462786;2482.8510289382693;2385.916492922748;2409.5301416223842;2423.466837295792;2429.307647320514;2429.671994280767;2054.445299769054;2116.354511873878;2374.169040835711;2379.262428647125;2379.940501487468;2078.9376318710465;2292.8165746740387;2370.5969985102574;2371.513839662882;2377.476955069882;8955.865662015074;9004.41471304363;9016.233620142295;9022.09779022099;9026.052264512196;5302.787888484456;5443.59173062018;5444.564434845203;5446.564274858041;5449.3460784706085;3487.47687846825;3611.963880361215;3644.69020133289;3745.0637340664834;3752.137008488063;1142.3146112332618;1147.3173461790304;1163.6043745126613;1202.1464760020397;1212.8120141378013;12862.742745145044;13117.278549679764;13137.868621313855;13217.669558261025;13231.073824832169;4754.619630429557;4784.593309568656;4931.284963680247;4943.209086546207;4975.378077740283;11165.888341116648;11170.162237832195;11197.16021298406;11199.888001120047;11204.887951120547;5491.148871924858;5520.806771762969;5554.72226388679;5564.527015203672;5566.610337276352;4200.663946884303;4876.219804831281;5047.394312682502;5112.846614601568;5116.692998420107;4169.478815148106;4183.163367326547;4214.536400995888;4219.894502637459;4262.339337402707;1300.2913412190378;1313.5008696695386;1327.9867201328057;1369.472752990086;1377.3403049325539;799.8440304140753;800.8678568036208;944.8677185194078;969.2827307792325;1002.5338217728792;5900.586958912835;5967;6127.295361033538;6192.8761424771255;6200.131981522591;482.43314105925396;486.4575997762469;492.5394755903242;496.83604410544433;655.8163714160042;4123.3196522574035;4288.24955632763;4293.2701440755145;4302.548232435549;4352.064306174188;10755.462226888625;11208.27146235492;11264.605738799102;11272.718182045515;11327.603533876274;10788.298760580537;11188.496517656726;11211.159163062803;11221.55113795439;11264.211505194722;8284.130166332568;8340.874886876702;8413.116622754646;8420.8315833683;8436.53599052058;5764.711764411846;5792.681402522901;5798.246227990334;5883.676397798162;6061.72722227492;10074.546645400827;10297;10318.380897146195;10445.373277603368;10455.843162352723;10435.530401132119;10435.94782026085;10456.581736730446;10466.63366782159;10578.576856925636;7273.745418910313;7867.095284042409;7891.250331218525;7980.441369104107;8082.555459449552;8877.112288771072;8895.955520222358;8978.685745998859;9021.368504204642;9023.187913087853;7738.535687858746;7996.56018918965;8115.066767321833;8203.425760196968;8213.835723285381;7810.57041862703;7835.686572537034;7856.960715196387;7889;8033.35733141359;7129.893051604334;7203.387712044325;7206.171290301682;7259;7277.9272207277245;5152.4847515248175;5209.453007434165;5220.608454366014;5272.393674727302;5311.654742441729;5228.9738551307;5260.0531904257605;5337.306150200449;5361.812336568201;5461.01701693683 06:08:36 INFO - PROCESS | 30946 | |4;prototype.html;342.479431264478;351.3605238465991;357.7174032514314;359.687072247145;359.9262151258992;5415.241866138744;5452.890942181159;5457.754401051952;5463.180522921563;5485.930243602495;5077.974610126944;5210.7655155518;5268.1834315681035;5287.074761916659;5357.678539287635;4191.350340697197;4216.009237829107;4217.493900731916;4248.766317852517;4260.126674031816;4199.223143718422;4232.449781528397;4234.9364759528635;4264.4882614086355;4283.957160428403;4013.2174226025936;4022.7787471689044;4171.833126674929;4206.663466922639;4241.854699231221;4164.729292595972;4181.560936101696;4208.305629571117;4208.516020657633;4217.599328063844;3752.5309336332957;3756.887293381203;3761.1161377076364;3761.962380376189;3765.4540091686554;5172.508611681884;5177.430482646906;5186.766595503173;5228.882302667425;5291.576673866081;4791.520847915215;4797.424309082898;4801.255805350142;4814.446338671028;4823.686460380064;5554.944450555524;5556.471970208185;5565.916511252334;5578.163275508666;5611.635243709186;4014.3175660137554;4097.938530922039;4109.4246805447265;4118.876433706963;4156.521999969982;5764.538836893039;5769;5775.104858746901;5789.16057171712;5795.072788353843;4237.5762423758;4239.427677263591;4241.172971270635;4244.1723863846255;4247.87256382309;4123.97938010308;4203.894902627459;4251.3622956556765;4280.978595107067;4302.225599392077;4710.858674239778;4754.168020596382;4755.144074066701;4765.070811191854;4786.8085276589245;5514.393416724157;5519.724013799294;5537.335519737658;5591.384947655754;5598.3484871962055;1395.6162055434634;1428.2858570714643;1434.7274017936559;1451.8185226846645;1462.4077248714289;1021.5749030102965;1023.7184774187009;1034.9172066234682;1037.7665025369383;1040.453761775074;5310.893782124336;5323;5325.4142044375085;5339.652922560022;5341.62608617393;5589.317127778689;5593.244911936918;5594.888102237933;5605.971970140205;5610.316904928505;5158.690478571298;5298.708571028554;5302.522772950376;5307.575393968474;5320.866978325573;2595.480903819244;2611.8041146914056;2647.6293318935363;2651.2443953473166;2658.6440915133035;5109.821156259587;5117;5121.8719532011255;5129.281900533928;5144.614153938394;4873.756312184377;5066.949330506722;5067.37843889959;5077.898442031139;5085.8728531787;5063.670861393997;5079.263506791494;5117.671459485925;5120.923186152285;5127.846164615067;4907.214845624683;4998.925445939894;5000.949990500048;5032.899342013066;5039.370078740158;4795.400574928134;4995.875103122451;4996.950030499648;5019.62352823547;5029.773660185374;5149.9742501287255;5155.711072231942;5169.612279079009;5169.92245116316;5232.3459567554055;3844.7308688392663;3861.9034524135996;3871.5160604924386;3872.7289089763444;3877.84488620452;5068.670536415121;5381.730913454233;5530.391656917816;5800.883982320414;5807.622504537191;5426.294581704353;5549.334079910436;5583.609147359808;5594.524465420485;5610.691411972381;5493.587980901369;5515.145152501369;5520.420355862577;5524.751386187711;5524.889502209853;5311.150215965427;5468.945310546844;5479.068558345011;5518.944810552004;5525.696086715269;5585.581081418829;5606.355269144101;5611.194402798601;5620.297462817148;5621.747021383966;5453.754581043783;5489.204065410573;5508.1822998409625;5526.640768350045;5527.695976721319 06:08:36 INFO - PROCESS | 30946 | |5;yui.html;776.4448419380144;795.041974420823;798.6885114805227;818.324881972373;847.3390755210936;15238.847611523881;15550.611234719137;15595.376184952602;15618;15679.686406271896;15359.07845529269;15569.455069072585;15572.37710491579;15573.922130389361;15580.298886550105;652.9771457998971;786.7049856303886;790.3756032734133;807.9474834135792;808.5350923219144;818.4802650317032;818.4884447220487;821.3716506872247;821.5522540215567;821.8890449789292;858.3390789092426;858.6565373850478;859.6647307550061;860.2000139869918;861.0958493581745;688.9896651550206;718.3283629806148;718.5078221418345;815.6533473273835;852.0840096895831;619.9194104766397;624.9937500624981;625.4402309932631;626.0640342687711;628.3433811666819;15347.846521534753;15387.307571159325;15406.075635461908;15420.845791542166;15432.922835385863;14697.338619762137;14706.191159486223;14837;14871.405143794234;15152.545423637199;11797.528098876035;11876.10929180315;11883.702907427298;12050.87949120515;12106.213096148722;3776.9244615107546;3915.5105611798526;3983.2630963271886;4058.6955978301744;4106.260873042851;77760;79092;79334.20665793326;79919;83067.5846620763;10884.564617415215;10896.945515272531;10969.427254246846;11275.267107637977;11750.529978800923;18362.724559131624;18396.35612753574;18400;18418.079096045145;18467.445976620722;8417;8470.280026197719;8543.145685431407;8559.101294364002;8785.912140878638;4593.471750748707;4630.560096790799;4707.929381059287;4778.1399348117675;4933.851984440401;3621.6016238213774;3736.7944763038295;3741.420079887622;3752.887413377603;3760.7555508891833;634.6097150252562;661.8469106357549;664.85705573301;675.8580698053365;681.1927865479423;736.3189050128609;745.1691364128957;762.3900879296541;774.0981756254014;811.9309858661961;10017.749556261151;10053.145482633912;10240.385576865412;10330.741731456623;10333.276670633133;637.2735082006516;638.6359923363704;706.7879636109146;732.6117157906318;776.7320274505287;4570.314452832035;5013.426156141223;5018.623603229772;5046.646734728607;5065.9746701266995;113318;116346;120122;120623;121488;59668.70165649144;61536;100153;100288;100396.49801750944;88924.555377224;88985;89308.5534572323;89391.55304223567;89612;8762.868556971778;8988.730338089868;9197.448153110834;9250.907490925005;9478.194353480032;50018.24972625341;50680.493195067575;50724.49275507198;50912.78093257517;51812.222816658534;65968.6701566489;67239.32760672526;68143.3185668137;77709;81408.18591814242;12925.741485170432;13312.800307995194;13368.598942031755;13625.86374136246;13785.931070344985;14898;15060.322285496959;15125.39498420051;15563.766543502083;16659.167041647626;13677;14179;14330.49843255481;14441.277936103363;15018.549443516711;14854.851451485347;14957.252137393305;15127.54617361481;15253.694926101638;15471.226438677795;12537.811932821198;12780.233186008869;12975.286359250333;13051.28217948022;13543.525976590772;11827.940860295988;11884.702882428008;12280.38598070075;12337.568185113478;12639.988800895722;11081.113510918945;11089.445527723743;12049.277043377426;12100.576479823163;12482.687932801753 06:08:36 INFO - PROCESS | 30946 | __end_tp_report 06:08:36 INFO - PROCESS | 30946 | __start_cc_report 06:08:36 INFO - PROCESS | 30946 | _x_x_mozilla_cycle_collect,862 06:08:36 INFO - PROCESS | 30946 | __end_cc_report 06:08:36 INFO - PROCESS | 30946 | __startTimestamp1467292116158__endTimestamp 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | ------- Summary: start ------- 06:08:36 INFO - PROCESS | 30946 | Number of tests: 6 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#0] dojo.html Cycles:165 Average:5430.60 Median:5639.97 stddev:628.49 (11.1%) stddev-sans-first:604.00 06:08:36 INFO - PROCESS | 30946 | Values: 3132.2 3137.5 3168.2 3171.4 3201.6 5234.1 5283.2 5444.3 5525.0 5564.4 5402.4 5407.8 5539.4 5583.2 5637.5 4943.2 4964.8 4973.8 4977.9 5135.7 5017.0 5039.9 5088.7 5103.7 5109.1 4869.8 4882.1 4940.9 4964.5 5037.7 4845.3 4849.8 4857.6 4908.1 4945.9 4897.7 4917.0 4924.2 4932.2 4935.0 5270.1 5363.1 5492.3 5495.3 5569.7 5786.4 5802.9 5805.9 5823.9 5836.3 5802.6 5839.1 5879.6 5892.8 5895.4 5472.6 5508.8 5519.4 5619.1 5625.3 6084.0 6085.5 6087.2 6122.4 6135.4 5594.6 5635.7 5836.2 5887.5 5893.5 5762.9 5882.1 5882.3 5883.3 5888.0 5739.3 5774.9 5786.3 5797.9 5805.9 5658.3 5729.1 5768.5 5790.2 5792.4 4448.6 4453.3 4458.0 4495.2 4495.5 3969.2 3976.1 3978.0 3984.8 4015.7 5463.2 5517.6 5524.7 5577.8 5585.4 5897.2 5912.4 5918.5 5924.1 5952.6 5645.1 5652.3 5655.4 5658.9 5659.7 4770.9 4816.4 4842.5 4855.4 4906.5 6072.6 6073.8 6078.0 6078.8 6080.0 5847.3 5862.4 5866.3 5869.6 5874.6 5873.1 6007.9 6052.6 6066.6 6136.1 5776.3 5810.0 5815.0 5818.1 5829.3 5665.4 5893.2 5903.8 5908.7 5909.8 5627.9 5640.5 5665.7 5726.1 5731.1 5640.0 5701.6 5707.6 5709.2 5713.3 5510.8 5552.5 5635.5 5636.4 5643.4 5692.2 5750.1 5756.1 5818.7 5825.3 5594.1 5619.8 5622.5 5624.9 5626.7 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#1] ext.html Cycles:180 Average:58176.78 Median:42384.08 stddev:114650.37 (270.5%) stddev-sans-first:114890.45 06:08:36 INFO - PROCESS | 30946 | Values: 581.2 609.2 623.0 626.6 629.8 33109.2 36125.3 36136.0 36227.5 43301.8 41745.4 45461.5 45494.8 45516.3 45524.3 8937.9 9125.0 9132.5 9132.9 9138.0 8961.9 9062.3 9067.3 9068.2 9070.2 9024.9 9096.0 9100.3 9105.1 9105.6 9027.6 9027.8 9070.0 9086.1 9088.7 8973.4 9037.5 9041.4 9043.6 9047.1 43828.3 44113.6 44210.8 44216.0 44288.3 3516.3 3678.0 3688.9 3689.5 3707.0 32613.5 33097.5 33244.3 33434.3 34005.0 4429.8 4485.6 4565.3 4584.2 4645.7 334292.0 337362.0 337818.0 339104.0 339802.0 53182.7 53466.0 53676.5 53724.5 53797.5 39823.6 40737.0 40773.6 40793.0 40815.4 16280.5 16363.9 16365.3 16370.0 16382.5 12949.3 13055.5 13060.5 13086.0 13107.0 19539.3 19600.0 19673.6 19778.3 19892.9 7016.7 7019.4 7189.9 7201.2 7332.6 850.5 945.2 954.6 964.2 1092.6 25904.5 26196.7 26225.2 26349.1 26624.9 1049.1 1052.5 1056.2 1068.3 1112.8 13162.0 13184.0 13198.3 13473.9 13647.2 531899.0 534176.0 536851.0 538097.6 540361.0 60081.7 60631.1 60664.0 60693.4 60741.4 1252.3 1280.5 1364.1 1381.6 1393.4 24613.6 25961.0 26260.0 26300.0 26501.5 51485.7 51900.5 52107.2 52109.5 52137.7 396488.1 399243.0 399375.0 399494.0 400860.0 25029.2 25871.7 29253.4 29357.9 31099.4 49324.0 49715.3 49889.3 49893.8 50188.5 41041.0 41243.1 42135.4 42694.1 43011.0 42089.4 44437.6 45938.0 46711.8 47264.0 41103.4 42632.8 42889.6 44330.3 45782.8 38086.8 38606.0 39376.0 39906.0 40448.2 28221.9 28247.4 28369.4 28502.9 28555.0 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#2] jquery.html Cycles:180 Average:29500.31 Median:2532.42 stddev:79628.38 (3144.4%) stddev-sans-first:79821.78 06:08:36 INFO - PROCESS | 30946 | Values: 396.9 399.2 410.6 416.3 424.3 15782.8 19538.3 19761.2 19891.7 20101.2 19402.8 19700.7 19791.5 20025.3 20048.2 5837.8 6044.0 6342.9 6852.8 6861.4 6536.1 6825.6 6827.2 6850.3 6899.7 6749.4 6775.6 6779.1 6790.0 6795.5 5614.8 5893.6 5897.6 6746.4 6753.5 5678.5 5679.9 5681.1 5694.5 5700.0 19676.7 22572.8 22894.8 23636.9 24138.0 2312.4 2384.1 2467.5 2484.0 2580.9 10547.8 10670.4 10867.5 11043.0 11290.4 1899.6 1936.2 1963.8 1985.5 2005.3 82142.6 87491.6 87757.0 88287.1 90554.0 10968.9 11148.6 11435.7 11680.7 11762.3 16216.4 16270.8 16340.3 16376.9 16414.1 8335.5 8413.0 8497.7 8565.9 8721.5 7921.7 7966.4 8040.2 8068.3 8334.9 4929.7 5023.2 5042.6 5119.3 5157.8 1962.6 1982.4 1994.6 2069.1 2073.1 937.0 965.6 975.4 1024.2 1077.8 18697.2 19284.9 19514.4 19597.6 19808.3 952.2 974.8 1020.8 1044.8 1063.4 10266.8 10907.3 10974.9 11024.8 11026.7 476305.0 480035.0 482198.0 483235.0 485538.0 91376.5 93459.0 95305.0 96450.0 97583.0 994.7 994.7 1017.4 1017.7 1023.9 17251.6 17386.0 17693.6 17737.9 17824.2 45720.5 46015.8 46477.3 46721.0 47014.0 61162.4 61328.4 61356.4 63217.0 63536.4 7926.3 7983.7 8346.7 8634.7 9033.2 11790.5 13460.2 13526.3 13996.7 14096.2 11715.7 11874.4 11887.3 12237.6 12290.7 11122.8 11750.8 11929.7 12269.6 12442.0 12022.9 12450.4 12454.6 12582.6 12624.6 9027.1 9122.7 9164.5 9272.5 9373.7 9504.3 11953.6 11966.6 12229.2 12254.7 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#3] mootools.html Cycles:180 Average:5964.35 Median:2681.34 stddev:3444.29 (128.5%) stddev-sans-first:3436.60 06:08:36 INFO - PROCESS | 30946 | Values: 1365.1 1477.5 1520.4 1675.4 1807.0 8480.7 8865.4 8873.1 8881.2 9059.1 8274.8 8547.6 8825.7 8839.2 8840.0 2063.1 2137.7 2139.0 2398.9 2454.7 2364.0 2461.1 2471.4 2481.2 2482.9 2385.9 2409.5 2423.5 2429.3 2429.7 2054.4 2116.4 2374.2 2379.3 2379.9 2078.9 2292.8 2370.6 2371.5 2377.5 8955.9 9004.4 9016.2 9022.1 9026.1 5302.8 5443.6 5444.6 5446.6 5449.3 3487.5 3612.0 3644.7 3745.1 3752.1 1142.3 1147.3 1163.6 1202.1 1212.8 12862.7 13117.3 13137.9 13217.7 13231.1 4754.6 4784.6 4931.3 4943.2 4975.4 11165.9 11170.2 11197.2 11199.9 11204.9 5491.1 5520.8 5554.7 5564.5 5566.6 4200.7 4876.2 5047.4 5112.8 5116.7 4169.5 4183.2 4214.5 4219.9 4262.3 1300.3 1313.5 1328.0 1369.5 1377.3 799.8 800.9 944.9 969.3 1002.5 5900.6 5967.0 6127.3 6192.9 6200.1 482.4 486.5 492.5 496.8 655.8 4123.3 4288.2 4293.3 4302.5 4352.1 10755.5 11208.3 11264.6 11272.7 11327.6 10788.3 11188.5 11211.2 11221.6 11264.2 8284.1 8340.9 8413.1 8420.8 8436.5 5764.7 5792.7 5798.2 5883.7 6061.7 10074.5 10297.0 10318.4 10445.4 10455.8 10435.5 10435.9 10456.6 10466.6 10578.6 7273.7 7867.1 7891.3 7980.4 8082.6 8877.1 8896.0 8978.7 9021.4 9023.2 7738.5 7996.6 8115.1 8203.4 8213.8 7810.6 7835.7 7857.0 7889.0 8033.4 7129.9 7203.4 7206.2 7259.0 7277.9 5152.5 5209.5 5220.6 5272.4 5311.7 5229.0 5260.1 5337.3 5361.8 5461.0 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#4] prototype.html Cycles:180 Average:4571.74 Median:5077.94 stddev:1299.78 (25.6%) stddev-sans-first:1264.07 06:08:36 INFO - PROCESS | 30946 | Values: 342.5 351.4 357.7 359.7 359.9 5415.2 5452.9 5457.8 5463.2 5485.9 5078.0 5210.8 5268.2 5287.1 5357.7 4191.4 4216.0 4217.5 4248.8 4260.1 4199.2 4232.4 4234.9 4264.5 4284.0 4013.2 4022.8 4171.8 4206.7 4241.9 4164.7 4181.6 4208.3 4208.5 4217.6 3752.5 3756.9 3761.1 3762.0 3765.5 5172.5 5177.4 5186.8 5228.9 5291.6 4791.5 4797.4 4801.3 4814.4 4823.7 5554.9 5556.5 5565.9 5578.2 5611.6 4014.3 4097.9 4109.4 4118.9 4156.5 5764.5 5769.0 5775.1 5789.2 5795.1 4237.6 4239.4 4241.2 4244.2 4247.9 4124.0 4203.9 4251.4 4281.0 4302.2 4710.9 4754.2 4755.1 4765.1 4786.8 5514.4 5519.7 5537.3 5591.4 5598.3 1395.6 1428.3 1434.7 1451.8 1462.4 1021.6 1023.7 1034.9 1037.8 1040.5 5310.9 5323.0 5325.4 5339.7 5341.6 5589.3 5593.2 5594.9 5606.0 5610.3 5158.7 5298.7 5302.5 5307.6 5320.9 2595.5 2611.8 2647.6 2651.2 2658.6 5109.8 5117.0 5121.9 5129.3 5144.6 4873.8 5066.9 5067.4 5077.9 5085.9 5063.7 5079.3 5117.7 5120.9 5127.8 4907.2 4998.9 5000.9 5032.9 5039.4 4795.4 4995.9 4997.0 5019.6 5029.8 5150.0 5155.7 5169.6 5169.9 5232.3 3844.7 3861.9 3871.5 3872.7 3877.8 5068.7 5381.7 5530.4 5800.9 5807.6 5426.3 5549.3 5583.6 5594.5 5610.7 5493.6 5515.1 5520.4 5524.8 5524.9 5311.2 5468.9 5479.1 5518.9 5525.7 5585.6 5606.4 5611.2 5620.3 5621.7 5453.8 5489.2 5508.2 5526.6 5527.7 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - PROCESS | 30946 | [#5] yui.html Cycles:180 Average:20691.47 Median:4020.98 stddev:29650.43 (737.4%) stddev-sans-first:29695.89 06:08:36 INFO - PROCESS | 30946 | Values: 776.4 795.0 798.7 818.3 847.3 15238.8 15550.6 15595.4 15618.0 15679.7 15359.1 15569.5 15572.4 15573.9 15580.3 653.0 786.7 790.4 807.9 808.5 818.5 818.5 821.4 821.6 821.9 858.3 858.7 859.7 860.2 861.1 689.0 718.3 718.5 815.7 852.1 619.9 625.0 625.4 626.1 628.3 15347.8 15387.3 15406.1 15420.8 15432.9 14697.3 14706.2 14837.0 14871.4 15152.5 11797.5 11876.1 11883.7 12050.9 12106.2 3776.9 3915.5 3983.3 4058.7 4106.3 77760.0 79092.0 79334.2 79919.0 83067.6 10884.6 10896.9 10969.4 11275.3 11750.5 18362.7 18396.4 18400.0 18418.1 18467.4 8417.0 8470.3 8543.1 8559.1 8785.9 4593.5 4630.6 4707.9 4778.1 4933.9 3621.6 3736.8 3741.4 3752.9 3760.8 634.6 661.8 664.9 675.9 681.2 736.3 745.2 762.4 774.1 811.9 10017.7 10053.1 10240.4 10330.7 10333.3 637.3 638.6 706.8 732.6 776.7 4570.3 5013.4 5018.6 5046.6 5066.0 113318.0 116346.0 120122.0 120623.0 121488.0 59668.7 61536.0 100153.0 100288.0 100396.5 88924.6 88985.0 89308.6 89391.6 89612.0 8762.9 8988.7 9197.4 9250.9 9478.2 50018.2 50680.5 50724.5 50912.8 51812.2 65968.7 67239.3 68143.3 77709.0 81408.2 12925.7 13312.8 13368.6 13625.9 13785.9 14898.0 15060.3 15125.4 15563.8 16659.2 13677.0 14179.0 14330.5 14441.3 15018.5 14854.9 14957.3 15127.5 15253.7 15471.2 12537.8 12780.2 12975.3 13051.3 13543.5 11827.9 11884.7 12280.4 12337.6 12640.0 11081.1 11089.4 12049.3 12100.6 12482.7 06:08:36 INFO - PROCESS | 30946 | -------- Summary: end -------- 06:08:36 INFO - PROCESS | 30946 | 06:08:36 INFO - TEST-INFO | 30946: exit 0 06:08:36 INFO - TEST-OK | dromaeo_css | took 1113208ms 06:08:36 INFO - TEST-START | kraken 06:08:36 INFO - operating with platform_type : linux_ 06:08:36 INFO - Initialising browser for kraken test... 06:08:36 INFO - TEST-INFO | started process 31136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk2cgMF/profile http://localhost:33738/getInfo.html) 06:08:40 INFO - PROCESS | 31136 | __metrics Screen width/height:1600/1200 06:08:40 INFO - PROCESS | 31136 | colorDepth:24 06:08:40 INFO - PROCESS | 31136 | Browser inner width/height: 1024/697 06:08:40 INFO - PROCESS | 31136 | __metrics 06:08:41 INFO - PROCESS | 31136 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:42 INFO - TEST-INFO | 31136: exit 0 06:08:42 INFO - Browser initialized. 06:08:42 INFO - Running cycle 1/1 for kraken test... 06:08:42 INFO - TEST-INFO | started process 31216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk2cgMF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:53 INFO - PROCESS | 31216 | RSS: Main: 157110272 06:08:53 INFO - PROCESS | 31216 | 06:08:56 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33738/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:57 INFO - PROCESS | 31216 | RSS: Main: 215576576 06:08:57 INFO - PROCESS | 31216 | 06:08:59 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33738/tests/kraken/driver.html?testName=audio-dft) 06:09:00 INFO - PROCESS | 31216 | RSS: Main: 204976128 06:09:00 INFO - PROCESS | 31216 | 06:09:03 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33738/tests/kraken/driver.html?testName=audio-fft) 06:09:04 INFO - PROCESS | 31216 | RSS: Main: 269484032 06:09:04 INFO - PROCESS | 31216 | 06:09:06 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33738/tests/kraken/driver.html?testName=audio-oscillator) 06:09:06 INFO - PROCESS | 31216 | RSS: Main: 180461568 06:09:06 INFO - PROCESS | 31216 | 06:09:09 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:09 INFO - PROCESS | 31216 | RSS: Main: 183865344 06:09:09 INFO - PROCESS | 31216 | 06:09:12 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33738/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:13 INFO - PROCESS | 31216 | RSS: Main: 218894336 06:09:13 INFO - PROCESS | 31216 | 06:09:16 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33738/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:17 INFO - PROCESS | 31216 | RSS: Main: 220143616 06:09:17 INFO - PROCESS | 31216 | 06:09:20 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33738/tests/kraken/driver.html?testName=json-parse-financial) 06:09:20 INFO - PROCESS | 31216 | RSS: Main: 221233152 06:09:20 INFO - PROCESS | 31216 | 06:09:22 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:22 INFO - PROCESS | 31216 | RSS: Main: 208969728 06:09:22 INFO - PROCESS | 31216 | 06:09:24 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:25 INFO - PROCESS | 31216 | RSS: Main: 211988480 06:09:25 INFO - PROCESS | 31216 | 06:09:27 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:27 INFO - PROCESS | 31216 | RSS: Main: 211070976 06:09:27 INFO - PROCESS | 31216 | 06:09:30 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:31 INFO - PROCESS | 31216 | RSS: Main: 225640448 06:09:31 INFO - PROCESS | 31216 | 06:09:33 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:34 INFO - PROCESS | 31216 | RSS: Main: 224817152 06:09:34 INFO - PROCESS | 31216 | 06:09:35 INFO - PROCESS | 31216 | Cycle 1(1): loaded http://localhost:33738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33738/tests/kraken/driver.html?testName=ai-astar) 06:09:36 INFO - PROCESS | 31216 | RSS: Main: 267493376 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | __start_tp_report 06:09:36 INFO - PROCESS | 31216 | _x_x_mozilla_page_load 06:09:36 INFO - PROCESS | 31216 | _x_x_mozilla_page_load_details 06:09:36 INFO - PROCESS | 31216 | |i|pagename|runs| 06:09:36 INFO - PROCESS | 31216 | |0;ai-astar;102;111;110;110;112;112;110;111;110;109 06:09:36 INFO - PROCESS | 31216 | |1;audio-beat-detection;144;120;117;185;119;124;141;116;159;116 06:09:36 INFO - PROCESS | 31216 | |2;audio-dft;162;162;163;162;161;164;162;162;163;162 06:09:36 INFO - PROCESS | 31216 | |3;audio-fft;73;75;76;120;74;75;74;73;103;75 06:09:36 INFO - PROCESS | 31216 | |4;audio-oscillator;84;84;115;85;85;84;120;84;84;137 06:09:36 INFO - PROCESS | 31216 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 06:09:36 INFO - PROCESS | 31216 | |6;imaging-darkroom;146;148;146;146;146;147;146;147;147;149 06:09:36 INFO - PROCESS | 31216 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;95;95 06:09:36 INFO - PROCESS | 31216 | |8;json-parse-financial;51;51;52;51;52;53;52;53;52;52 06:09:36 INFO - PROCESS | 31216 | |9;json-stringify-tinderbox;61;62;62;61;62;61;61;61;62;61 06:09:36 INFO - PROCESS | 31216 | |10;stanford-crypto-aes;76;83;75;76;74;75;80;75;74;79 06:09:36 INFO - PROCESS | 31216 | |11;stanford-crypto-ccm;119;118;127;126;118;132;120;127;166;129 06:09:36 INFO - PROCESS | 31216 | |12;stanford-crypto-pbkdf2;159;156;153;157;157;162;156;157;161;157 06:09:36 INFO - PROCESS | 31216 | |13;stanford-crypto-sha256-iterative;63;63;63;63;62;62;63;63;64;62 06:09:36 INFO - PROCESS | 31216 | __end_tp_report 06:09:36 INFO - PROCESS | 31216 | __start_cc_report 06:09:36 INFO - PROCESS | 31216 | _x_x_mozilla_cycle_collect,1650 06:09:36 INFO - PROCESS | 31216 | __end_cc_report 06:09:36 INFO - PROCESS | 31216 | __startTimestamp1467292176214__endTimestamp 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | ------- Summary: start ------- 06:09:36 INFO - PROCESS | 31216 | Number of tests: 14 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.87 (2.6%) stddev-sans-first:1.01 06:09:36 INFO - PROCESS | 31216 | Values: 102.0 111.0 110.0 110.0 112.0 112.0 110.0 111.0 110.0 109.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:132.50 stddev:23.17 (17.5%) stddev-sans-first:24.30 06:09:36 INFO - PROCESS | 31216 | Values: 144.0 120.0 117.0 185.0 119.0 124.0 141.0 116.0 159.0 116.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:09:36 INFO - PROCESS | 31216 | Values: 162.0 162.0 163.0 162.0 161.0 164.0 162.0 162.0 163.0 162.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:16.19 (21.7%) stddev-sans-first:16.85 06:09:36 INFO - PROCESS | 31216 | Values: 73.0 75.0 76.0 120.0 74.0 75.0 74.0 73.0 103.0 75.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:19.94 (23.7%) stddev-sans-first:20.66 06:09:36 INFO - PROCESS | 31216 | Values: 84.0 84.0 115.0 85.0 85.0 84.0 120.0 84.0 84.0 137.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:09:36 INFO - PROCESS | 31216 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 06:09:36 INFO - PROCESS | 31216 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 149.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:09:36 INFO - PROCESS | 31216 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 06:09:36 INFO - PROCESS | 31216 | Values: 51.0 51.0 52.0 51.0 52.0 53.0 52.0 53.0 52.0 52.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:09:36 INFO - PROCESS | 31216 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 61.0 61.0 62.0 61.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.98 (3.9%) stddev-sans-first:3.15 06:09:36 INFO - PROCESS | 31216 | Values: 76.0 83.0 75.0 76.0 74.0 75.0 80.0 75.0 74.0 79.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:127.00 stddev:14.19 (11.2%) stddev-sans-first:14.65 06:09:36 INFO - PROCESS | 31216 | Values: 119.0 118.0 127.0 126.0 118.0 132.0 120.0 127.0 166.0 129.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.00 stddev:2.59 (1.7%) stddev-sans-first:2.69 06:09:36 INFO - PROCESS | 31216 | Values: 159.0 156.0 153.0 157.0 157.0 162.0 156.0 157.0 161.0 157.0 06:09:36 INFO - PROCESS | 31216 | 06:09:36 INFO - PROCESS | 31216 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:09:36 INFO - PROCESS | 31216 | Values: 63.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 64.0 62.0 06:09:36 INFO - PROCESS | 31216 | -------- Summary: end -------- 06:09:36 INFO - PROCESS | 31216 | 06:09:37 INFO - TEST-INFO | 31216: exit 0 06:09:37 INFO - TEST-OK | kraken | took 60347ms 06:09:37 INFO - SUITE-END | took 1173s 06:09:37 INFO - Completed test suite (00:19:33) 06:09:37 INFO - javascript benchmark 06:09:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.232603012262, 3137.545055966885, 3168.2396224906024, 3171.3815805917857, 3201.6318123415813, 5234.057869583474, 5283.181106928422, 5444.346678398593, 5524.972375138123, 5564.415736347681, 5402.37872644646, 5407.810726624569, 5539.390667026634, 5583.190437386586, 5637.46444087811, 4943.184374578191, 4964.826231081913, 4973.825916092937, 4977.900441991158, 5135.691858488484, 5016.974915125419, 5039.874003149914, 5088.669236499634, 5103.719295438749, 5109.105906466372, 4869.756512174377, 4882.145624515695, 4940.876478088041, 4964.453910069889, 5037.697738135724, 4845.27320901864, 4849.75751212438, 4857.587105096036, 4908.141075311842, 4945.9258111128365, 4897.730624815634, 4916.950830491721, 4924.1875090610365, 4932.186189278765, 4935.0376676548085, 5270.077736396115, 5363.061464243741, 5492.313460817398, 5495.2856128703015, 5569.749361278752, 5786.421357864222, 5802.88394232113, 5805.941940580582, 5823.941760582382, 5836.270466191726, 5802.622829516068, 5839.0949402842625, 5879.588428809985, 5892.823215303548, 5895.35151133375, 5472.616916815825, 5508.834734957958, 5519.39286678465, 5619.072852979212, 5625.268715067015, 6084.026555751058, 6085.5435842312, 6087.164846573107, 6122.387761223842, 6135.355787642323, 5594.636348637326, 5635.6618602883955, 5836.2412886325355, 5887.470127688529, 5893.528517718572, 5762.9135562966585, 5882.147088672119, 5882.294124704978, 5883.294004719461, 5887.970560147171, 5739.253896993364, 5774.913376299359, 5786.334571524244, 5797.884042319214, 5805.94194058054, 5658.264425624725, 5729.083346664514, 5768.451997060272, 5790.189373487715, 5792.362840087587, 4448.5773851484055, 4453.309736990772, 4457.977710111493, 4495.213337665896, 4495.483019452739, 3969.226000929791, 3976.1252524444576, 3977.960220397817, 3984.780837053932, 4015.7389769665465, 5463.207834864002, 5517.5585953123655, 5524.696141712164, 5577.776888924479, 5585.413531579125, 5897.174395584621, 5912.40875912414, 5918.526517878559, 5924.11138329254, 5952.553558483044, 5645.096784514458, 5652.349979752299, 5655.4344565543115, 5658.943410565842, 5659.660420374791, 4770.856874293708, 4816.373871396696, 4842.467328593852, 4855.36880205571, 4906.533879281463, 6072.635641861591, 6073.75704971805, 6077.969610151921, 6078.787242446493, 6080.0, 5847.327557330791, 5862.355140934579, 5866.2960444746905, 5869.559783016205, 5874.618149820248, 5873.148393483007, 6007.948608993322, 6052.606580572248, 6066.636001839904, 6136.140940268455, 5776.306843178677, 5810.0, 5815.0, 5818.069108942549, 5829.3296270927685, 5665.405132461197, 5893.174955506318, 5903.822885313448, 5908.734106965283, 5909.763609455746, 5627.8593035174445, 5640.548756099584, 5665.688387138747, 5726.0838265877255, 5731.054376027909, 5639.971800140973, 5701.600887937804, 5707.600467967202, 5709.200711900255, 5713.257276554187, 5510.834674959758, 5552.500274975271, 5635.464630860061, 5636.436356364331, 5643.407442218672, 5692.174634678031, 5750.108733146369, 5756.107803290497, 5818.7090645466715, 5825.271841019872, 5594.104943209067, 5619.775208991595, 5622.465865742748, 5624.859378515406, 5626.746796394254], "value": 5387.608427300914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2124571206016, 609.1897775957975, 622.9876450767503, 626.6490765171504, 629.8299459146028, 33109.17227069324, 36125.27749445013, 36136.0, 36227.456588151195, 43301.78349108258, 41745.373819392735, 45461.545384546145, 45494.77252613741, 45516.3172552412, 45524.317135243, 8937.910620893788, 9125.0, 9132.543372831331, 9132.863007054899, 9138.0, 8961.910380896174, 9062.320325975545, 9067.274618030575, 9068.183863452288, 9070.183683468487, 9024.909750902505, 9095.954520227422, 9100.271978241724, 9105.135012173865, 9105.63577456901, 9027.638894444215, 9027.819443611124, 9070.002299747022, 9086.136817002407, 9088.727338179866, 8973.416727912665, 9037.502937338444, 9041.3671043027, 9043.638254469814, 9047.095290470967, 43828.34257486108, 44113.558864411265, 44210.77894610538, 44216.0, 44288.3356749649, 3516.314318707853, 3678.0437086357474, 3688.926221475582, 3689.538807649044, 3706.9629303707156, 32613.51079733806, 33097.48819942719, 33244.3351132976, 33434.331313373594, 34005.0, 4429.822807087713, 4485.573870482299, 4565.292379681122, 4584.243599806028, 4645.698029628097, 334292.0, 337362.0, 337818.0, 339104.0, 339802.0, 53182.73408632932, 53466.0, 53676.46323536715, 53724.462755372726, 53797.462025379245, 39823.601763982566, 40737.0, 40773.59226407698, 40793.0, 40815.387769183486, 16280.511584652479, 16363.91818040926, 16365.345386184657, 16370.0, 16382.508524744277, 12949.287789171498, 13055.543055992996, 13060.477580896848, 13086.0, 13107.0, 19539.316123935594, 19600.0, 19673.606527869364, 19778.30775922836, 19892.90053549752, 7016.7193312267955, 7019.3682568569075, 7189.856202875913, 7201.207867134611, 7332.560046397233, 850.46420754924, 945.1965829045256, 954.6181527388961, 964.243069190696, 1092.6230450494568, 25904.481910361686, 26196.73803261981, 26225.213243602724, 26349.077782277527, 26624.8668756655, 1049.1187402581716, 1052.489542571852, 1056.2025670618634, 1068.3056013591229, 1112.8163852964333, 13162.0, 13184.0, 13198.340082996005, 13473.932630336785, 13647.181169129884, 531899.0, 534176.0, 536851.0, 538097.6426767929, 540361.0, 60081.69959150176, 60631.09053364203, 60664.0, 60693.39306606966, 60741.392586073576, 1252.2549083295426, 1280.4686055287139, 1364.0724307470816, 1381.5579014715395, 1393.3590548347875, 24613.63079553844, 25961.0, 26260.0, 26300.0, 26501.469970600865, 51485.7425712869, 51900.480995189566, 52107.21839172491, 52109.47890521046, 52137.7393113032, 396488.08779780735, 399243.0, 399375.0, 399494.0, 400860.0, 25029.249122526355, 25871.741282586932, 29253.41493170167, 29357.85321073381, 31099.37801243917, 49324.0, 49715.254271186684, 49889.25166122583, 49893.75053124711, 50188.49811501838, 41041.0, 41243.08717268566, 42135.36796947987, 42694.14611707686, 43011.0, 42089.36865946952, 44437.55562444334, 45938.0, 46711.76644116758, 47264.0, 41103.38344924769, 42632.78683606562, 42889.63436086145, 44330.335044973704, 45782.771086144356, 38086.80956595199, 38606.0, 39376.0, 39906.0, 40448.19103617852, 28221.858890705415, 28247.43505129927, 28369.432611347245, 28502.91297880025, 28555.0], "value": 19647.504203182187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.9404589311601, 399.24941110711876, 410.6160739708373, 416.29853696521366, 424.30202317188224, 15782.763258551116, 19538.316158934405, 19761.209551617936, 19891.70162447561, 20101.195952161932, 19402.805971940277, 19700.70448943267, 19791.5052123697, 20025.299114530993, 20048.1980720771, 5837.766489340422, 6044.0, 6342.904856427157, 6852.760153394632, 6861.382475577197, 6536.117624120754, 6825.556338837984, 6827.180738311409, 6850.280720524348, 6899.6550172491425, 6749.392554670078, 6775.62734049627, 6779.0509328694025, 6789.966050169767, 6795.456363490934, 5614.775408983656, 5893.5579831512805, 5897.587168898179, 6746.426553742913, 6753.527253092286, 5678.545716342683, 5679.858003549903, 5681.119426488859, 5694.459026392527, 5700.030994730906, 19676.70484942727, 22572.774272257233, 22894.77105228943, 23636.881815590983, 24138.0, 2312.410335364488, 2384.094044263169, 2467.543504451682, 2483.950320993588, 2580.8967641294325, 10547.84178237327, 10670.413127277996, 10867.510962006729, 11043.0, 11290.379029153393, 1899.5536049028467, 1936.1674479973606, 1963.7741659709172, 1985.5397656444777, 2005.2780998840406, 82142.58928705378, 87491.56254218752, 87757.0, 88287.0541651248, 90554.0, 10968.945155274332, 11148.609798657008, 11435.655690583577, 11680.70798230051, 11762.294262344287, 16216.432424865308, 16270.83729162717, 16340.346386144658, 16376.918115409348, 16414.09722465252, 8335.54154521495, 8413.0, 8497.702580409656, 8565.914340856636, 8721.520316382659, 7921.683132674743, 7966.402519811038, 8040.2361775631225, 8068.314193293636, 8334.874976875351, 4929.693631187738, 5023.196288593807, 5042.647014708935, 5119.283300337956, 5157.793688252503, 1962.607478504305, 1982.3656429942569, 1994.5711671990302, 2069.1413063578448, 2073.139647046459, 936.9531523423801, 965.5799727118725, 975.3903810118676, 1024.1806554756315, 1077.7952189084206, 18697.15862786178, 19284.939328337077, 19514.414567562995, 19597.608047838963, 19808.33209196093, 952.1620973543376, 974.848898420746, 1020.7907378987289, 1044.754482696581, 1063.4310643805527, 10266.845997310047, 10907.34555926631, 10974.945125274482, 11024.779504409868, 11026.669199924016, 476305.0, 480035.0, 482198.0, 483235.0, 485538.0, 91376.54311728399, 93459.0, 95305.0, 96450.0, 97583.0, 994.6667866264737, 994.6916455898695, 1017.399734156851, 1017.6590842067842, 1023.8822535408524, 17251.568710782332, 17386.0, 17693.55766105806, 17737.911310443364, 17824.197911093772, 45720.54279457296, 46015.76992115018, 46477.3028404581, 46721.0, 47014.0, 61162.38837611567, 61328.38671613227, 61356.386436135064, 63217.0, 63536.36463635489, 7926.326262267772, 7983.72056978003, 8346.707865224687, 8634.697785577475, 9033.187013168847, 11790.469428875549, 13460.192388456724, 13526.323683815966, 13996.65008374758, 14096.154230746188, 11715.707107322385, 11874.406279685809, 11887.28676279426, 12237.632871013884, 12290.692732681755, 11122.777544449227, 11750.764984700429, 11929.701757456132, 12269.631911042683, 12442.0, 12022.879771202175, 12450.377481125726, 12454.564090256797, 12582.559610413591, 12624.621261362174, 9027.14242146995, 9122.726318210463, 9164.495952722664, 9272.490013049348, 9373.718788436357, 9504.287178461505, 11953.581624643095, 11966.64100076999, 12229.205101668364, 12254.693632659255], "value": 9593.0077068279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.0649305225927, 1477.5198060630294, 1520.3766455753141, 1675.3968571314333, 1806.9819301806986, 8480.703175388862, 8865.379423440354, 8873.068327825582, 8881.245094166996, 9059.094090590937, 8274.751757447271, 8547.615357308921, 8825.735227943156, 8839.160279773427, 8840.027596964344, 2063.071617772001, 2137.690034944932, 2138.9893050534724, 2398.8920498577563, 2454.6686197363397, 2363.9645405318934, 2461.064795377763, 2471.4315707387314, 2481.2308184462786, 2482.8510289382693, 2385.916492922748, 2409.5301416223842, 2423.466837295792, 2429.307647320514, 2429.671994280767, 2054.445299769054, 2116.354511873878, 2374.169040835711, 2379.262428647125, 2379.940501487468, 2078.9376318710465, 2292.8165746740387, 2370.5969985102574, 2371.513839662882, 2377.476955069882, 8955.865662015074, 9004.41471304363, 9016.233620142295, 9022.09779022099, 9026.052264512196, 5302.787888484456, 5443.59173062018, 5444.564434845203, 5446.564274858041, 5449.3460784706085, 3487.47687846825, 3611.963880361215, 3644.69020133289, 3745.0637340664834, 3752.137008488063, 1142.3146112332618, 1147.3173461790304, 1163.6043745126613, 1202.1464760020397, 1212.8120141378013, 12862.742745145044, 13117.278549679764, 13137.868621313855, 13217.669558261025, 13231.073824832169, 4754.619630429557, 4784.593309568656, 4931.284963680247, 4943.209086546207, 4975.378077740283, 11165.888341116648, 11170.162237832195, 11197.16021298406, 11199.888001120047, 11204.887951120547, 5491.148871924858, 5520.806771762969, 5554.72226388679, 5564.527015203672, 5566.610337276352, 4200.663946884303, 4876.219804831281, 5047.394312682502, 5112.846614601568, 5116.692998420107, 4169.478815148106, 4183.163367326547, 4214.536400995888, 4219.894502637459, 4262.339337402707, 1300.2913412190378, 1313.5008696695386, 1327.9867201328057, 1369.472752990086, 1377.3403049325539, 799.8440304140753, 800.8678568036208, 944.8677185194078, 969.2827307792325, 1002.5338217728792, 5900.586958912835, 5967.0, 6127.295361033538, 6192.8761424771255, 6200.131981522591, 482.43314105925396, 486.4575997762469, 492.5394755903242, 496.83604410544433, 655.8163714160042, 4123.3196522574035, 4288.24955632763, 4293.2701440755145, 4302.548232435549, 4352.064306174188, 10755.462226888625, 11208.27146235492, 11264.605738799102, 11272.718182045515, 11327.603533876274, 10788.298760580537, 11188.496517656726, 11211.159163062803, 11221.55113795439, 11264.211505194722, 8284.130166332568, 8340.874886876702, 8413.116622754646, 8420.8315833683, 8436.53599052058, 5764.711764411846, 5792.681402522901, 5798.246227990334, 5883.676397798162, 6061.72722227492, 10074.546645400827, 10297.0, 10318.380897146195, 10445.373277603368, 10455.843162352723, 10435.530401132119, 10435.94782026085, 10456.581736730446, 10466.63366782159, 10578.576856925636, 7273.745418910313, 7867.095284042409, 7891.250331218525, 7980.441369104107, 8082.555459449552, 8877.112288771072, 8895.955520222358, 8978.685745998859, 9021.368504204642, 9023.187913087853, 7738.535687858746, 7996.56018918965, 8115.066767321833, 8203.425760196968, 8213.835723285381, 7810.57041862703, 7835.686572537034, 7856.960715196387, 7889.0, 8033.35733141359, 7129.893051604334, 7203.387712044325, 7206.171290301682, 7259.0, 7277.9272207277245, 5152.4847515248175, 5209.453007434165, 5220.608454366014, 5272.393674727302, 5311.654742441729, 5228.9738551307, 5260.0531904257605, 5337.306150200449, 5361.812336568201, 5461.01701693683], "value": 4681.999867246086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.479431264478, 351.3605238465991, 357.7174032514314, 359.687072247145, 359.9262151258992, 5415.241866138744, 5452.890942181159, 5457.754401051952, 5463.180522921563, 5485.930243602495, 5077.974610126944, 5210.7655155518, 5268.1834315681035, 5287.074761916659, 5357.678539287635, 4191.350340697197, 4216.009237829107, 4217.493900731916, 4248.766317852517, 4260.126674031816, 4199.223143718422, 4232.449781528397, 4234.9364759528635, 4264.4882614086355, 4283.957160428403, 4013.2174226025936, 4022.7787471689044, 4171.833126674929, 4206.663466922639, 4241.854699231221, 4164.729292595972, 4181.560936101696, 4208.305629571117, 4208.516020657633, 4217.599328063844, 3752.5309336332957, 3756.887293381203, 3761.1161377076364, 3761.962380376189, 3765.4540091686554, 5172.508611681884, 5177.430482646906, 5186.766595503173, 5228.882302667425, 5291.576673866081, 4791.520847915215, 4797.424309082898, 4801.255805350142, 4814.446338671028, 4823.686460380064, 5554.944450555524, 5556.471970208185, 5565.916511252334, 5578.163275508666, 5611.635243709186, 4014.3175660137554, 4097.938530922039, 4109.4246805447265, 4118.876433706963, 4156.521999969982, 5764.538836893039, 5769.0, 5775.104858746901, 5789.16057171712, 5795.072788353843, 4237.5762423758, 4239.427677263591, 4241.172971270635, 4244.1723863846255, 4247.87256382309, 4123.97938010308, 4203.894902627459, 4251.3622956556765, 4280.978595107067, 4302.225599392077, 4710.858674239778, 4754.168020596382, 4755.144074066701, 4765.070811191854, 4786.8085276589245, 5514.393416724157, 5519.724013799294, 5537.335519737658, 5591.384947655754, 5598.3484871962055, 1395.6162055434634, 1428.2858570714643, 1434.7274017936559, 1451.8185226846645, 1462.4077248714289, 1021.5749030102965, 1023.7184774187009, 1034.9172066234682, 1037.7665025369383, 1040.453761775074, 5310.893782124336, 5323.0, 5325.4142044375085, 5339.652922560022, 5341.62608617393, 5589.317127778689, 5593.244911936918, 5594.888102237933, 5605.971970140205, 5610.316904928505, 5158.690478571298, 5298.708571028554, 5302.522772950376, 5307.575393968474, 5320.866978325573, 2595.480903819244, 2611.8041146914056, 2647.6293318935363, 2651.2443953473166, 2658.6440915133035, 5109.821156259587, 5117.0, 5121.8719532011255, 5129.281900533928, 5144.614153938394, 4873.756312184377, 5066.949330506722, 5067.37843889959, 5077.898442031139, 5085.8728531787, 5063.670861393997, 5079.263506791494, 5117.671459485925, 5120.923186152285, 5127.846164615067, 4907.214845624683, 4998.925445939894, 5000.949990500048, 5032.899342013066, 5039.370078740158, 4795.400574928134, 4995.875103122451, 4996.950030499648, 5019.62352823547, 5029.773660185374, 5149.9742501287255, 5155.711072231942, 5169.612279079009, 5169.92245116316, 5232.3459567554055, 3844.7308688392663, 3861.9034524135996, 3871.5160604924386, 3872.7289089763444, 3877.84488620452, 5068.670536415121, 5381.730913454233, 5530.391656917816, 5800.883982320414, 5807.622504537191, 5426.294581704353, 5549.334079910436, 5583.609147359808, 5594.524465420485, 5610.691411972381, 5493.587980901369, 5515.145152501369, 5520.420355862577, 5524.751386187711, 5524.889502209853, 5311.150215965427, 5468.945310546844, 5479.068558345011, 5518.944810552004, 5525.696086715269, 5585.581081418829, 5606.355269144101, 5611.194402798601, 5620.297462817148, 5621.747021383966, 5453.754581043783, 5489.204065410573, 5508.1822998409625, 5526.640768350045, 5527.695976721319], "value": 4170.583601956983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.4448419380144, 795.041974420823, 798.6885114805227, 818.324881972373, 847.3390755210936, 15238.847611523881, 15550.611234719137, 15595.376184952602, 15618.0, 15679.686406271896, 15359.07845529269, 15569.455069072585, 15572.37710491579, 15573.922130389361, 15580.298886550105, 652.9771457998971, 786.7049856303886, 790.3756032734133, 807.9474834135792, 808.5350923219144, 818.4802650317032, 818.4884447220487, 821.3716506872247, 821.5522540215567, 821.8890449789292, 858.3390789092426, 858.6565373850478, 859.6647307550061, 860.2000139869918, 861.0958493581745, 688.9896651550206, 718.3283629806148, 718.5078221418345, 815.6533473273835, 852.0840096895831, 619.9194104766397, 624.9937500624981, 625.4402309932631, 626.0640342687711, 628.3433811666819, 15347.846521534753, 15387.307571159325, 15406.075635461908, 15420.845791542166, 15432.922835385863, 14697.338619762137, 14706.191159486223, 14837.0, 14871.405143794234, 15152.545423637199, 11797.528098876035, 11876.10929180315, 11883.702907427298, 12050.87949120515, 12106.213096148722, 3776.9244615107546, 3915.5105611798526, 3983.2630963271886, 4058.6955978301744, 4106.260873042851, 77760.0, 79092.0, 79334.20665793326, 79919.0, 83067.5846620763, 10884.564617415215, 10896.945515272531, 10969.427254246846, 11275.267107637977, 11750.529978800923, 18362.724559131624, 18396.35612753574, 18400.0, 18418.079096045145, 18467.445976620722, 8417.0, 8470.280026197719, 8543.145685431407, 8559.101294364002, 8785.912140878638, 4593.471750748707, 4630.560096790799, 4707.929381059287, 4778.1399348117675, 4933.851984440401, 3621.6016238213774, 3736.7944763038295, 3741.420079887622, 3752.887413377603, 3760.7555508891833, 634.6097150252562, 661.8469106357549, 664.85705573301, 675.8580698053365, 681.1927865479423, 736.3189050128609, 745.1691364128957, 762.3900879296541, 774.0981756254014, 811.9309858661961, 10017.749556261151, 10053.145482633912, 10240.385576865412, 10330.741731456623, 10333.276670633133, 637.2735082006516, 638.6359923363704, 706.7879636109146, 732.6117157906318, 776.7320274505287, 4570.314452832035, 5013.426156141223, 5018.623603229772, 5046.646734728607, 5065.9746701266995, 113318.0, 116346.0, 120122.0, 120623.0, 121488.0, 59668.70165649144, 61536.0, 100153.0, 100288.0, 100396.49801750944, 88924.555377224, 88985.0, 89308.5534572323, 89391.55304223567, 89612.0, 8762.868556971778, 8988.730338089868, 9197.448153110834, 9250.907490925005, 9478.194353480032, 50018.24972625341, 50680.493195067575, 50724.49275507198, 50912.78093257517, 51812.222816658534, 65968.6701566489, 67239.32760672526, 68143.3185668137, 77709.0, 81408.18591814242, 12925.741485170432, 13312.800307995194, 13368.598942031755, 13625.86374136246, 13785.931070344985, 14898.0, 15060.322285496959, 15125.39498420051, 15563.766543502083, 16659.167041647626, 13677.0, 14179.0, 14330.49843255481, 14441.277936103363, 15018.549443516711, 14854.851451485347, 14957.252137393305, 15127.54617361481, 15253.694926101638, 15471.226438677795, 12537.811932821198, 12780.233186008869, 12975.286359250333, 13051.28217948022, 13543.525976590772, 11827.940860295988, 11884.702882428008, 12280.38598070075, 12337.568185113478, 12639.988800895722, 11081.113510918945, 11089.445527723743, 12049.277043377426, 12100.576479823163, 12482.687932801753], "value": 7635.250300481586, "unit": "score"}], "name": "dromaeo_css", "value": 7300.608995449497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 112.0, 112.0, 110.0, 111.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 117.0, 185.0, 119.0, 124.0, 141.0, 116.0, 159.0, 116.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 164.0, 162.0, 162.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 120.0, 74.0, 75.0, 74.0, 73.0, 103.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 85.0, 85.0, 84.0, 120.0, 84.0, 84.0, 137.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 149.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 75.0, 76.0, 74.0, 75.0, 80.0, 75.0, 74.0, 79.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 127.0, 126.0, 118.0, 132.0, 120.0, 127.0, 166.0, 129.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 153.0, 157.0, 157.0, 162.0, 156.0, 157.0, 161.0, 157.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 64.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1480.9, "alertThreshold": 2.0}]} 06:09:37 INFO - Return code: 0 06:09:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:37 INFO - # TBPL SUCCESS # 06:09:37 INFO - Running post-action listener: _resource_record_post_action 06:09:37 INFO - ##### 06:09:37 INFO - ##### Finished run-tests step (success) 06:09:37 INFO - ##### 06:09:37 INFO - Running post-run listener: _resource_record_post_run 06:09:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555745280; Read time: 16; Write time: 383900 06:09:37 INFO - TinderboxPrint: CPU usage
13.0% 06:09:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:09:37 INFO - TinderboxPrint: I/O write bytes / time
555,745,280 / 383,900 06:09:37 INFO - TinderboxPrint: CPU idle
8,265.6 (86.9%) 06:09:37 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 06:09:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 255688704; Read time: 0; Write time: 196688 06:09:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 299741184; Read time: 0; Write time: 187192 06:09:38 INFO - Running post-run listener: _upload_blobber_files 06:09:38 INFO - Blob upload gear active. 06:09:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:39 INFO - (blobuploader) - INFO - Done attempting. 06:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:42 INFO - (blobuploader) - INFO - Done attempting. 06:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:43 INFO - (blobuploader) - INFO - Done attempting. 06:09:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:43 INFO - Return code: 0 06:09:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9861e2086b73ecc53f3452b4c08171c5b8f19761c64afb46454c31b257a1429c929f44d4c3408f97207f66f8abee92481a39576d8f49199f20df24b97ad7cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f2fd40ec9eb1d3cec796b0d1a13e656639049e45271b5537de499a9a83b7337b32209c970d95a85ac82d46df12c372e070a260d8075ab28af38e4d90ba9792f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf091154763511193b727d6c716f26f45008cf15f76502997ff5f87d60c806f8610a3ad73c2eed1766ed9b6448701c8274b4dffbdb4d2c842eaa667bdc08a640"} 06:09:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:43 INFO - Contents: 06:09:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9861e2086b73ecc53f3452b4c08171c5b8f19761c64afb46454c31b257a1429c929f44d4c3408f97207f66f8abee92481a39576d8f49199f20df24b97ad7cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f2fd40ec9eb1d3cec796b0d1a13e656639049e45271b5537de499a9a83b7337b32209c970d95a85ac82d46df12c372e070a260d8075ab28af38e4d90ba9792f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf091154763511193b727d6c716f26f45008cf15f76502997ff5f87d60c806f8610a3ad73c2eed1766ed9b6448701c8274b4dffbdb4d2c842eaa667bdc08a640"} 06:09:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:43 INFO - Copying logs to upload dir... 06:09:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.510393 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 06:09:42.921536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 06:09:42.925529) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9861e2086b73ecc53f3452b4c08171c5b8f19761c64afb46454c31b257a1429c929f44d4c3408f97207f66f8abee92481a39576d8f49199f20df24b97ad7cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f2fd40ec9eb1d3cec796b0d1a13e656639049e45271b5537de499a9a83b7337b32209c970d95a85ac82d46df12c372e070a260d8075ab28af38e4d90ba9792f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf091154763511193b727d6c716f26f45008cf15f76502997ff5f87d60c806f8610a3ad73c2eed1766ed9b6448701c8274b4dffbdb4d2c842eaa667bdc08a640"} build_url:https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/eVPhcWO3T8Oy2SbRDM2f_Q/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/Firefox/sha512/ce9861e2086b73ecc53f3452b4c08171c5b8f19761c64afb46454c31b257a1429c929f44d4c3408f97207f66f8abee92481a39576d8f49199f20df24b97ad7cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f2fd40ec9eb1d3cec796b0d1a13e656639049e45271b5537de499a9a83b7337b32209c970d95a85ac82d46df12c372e070a260d8075ab28af38e4d90ba9792f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf091154763511193b727d6c716f26f45008cf15f76502997ff5f87d60c806f8610a3ad73c2eed1766ed9b6448701c8274b4dffbdb4d2c842eaa667bdc08a640"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 06:09:42.951176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:09:42.951567) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467290950.379003-141210255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:09:43.035928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:09:43.036738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 06:09:43.037158) ========= ========= Total master_lag: 0.17 =========