builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1467381978.44 results: success (0) buildid: 20160701043024 builduid: 99e80d248f374e959f5454b14421704c revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.436180) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.436874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.437473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.464659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.464981) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 07:06:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.0M=0s 2016-07-01 07:06:19 (88.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.694909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.695259) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015475 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.747177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:18.747547) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fdcee57b4e4f66a82831ab01e61500da98a858e8 --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 fdcee57b4e4f66a82831ab01e61500da98a858e8 --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=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 07:06:19,132 truncating revision to first 12 chars 2016-07-01 07:06:19,132 Setting DEBUG logging. 2016-07-01 07:06:19,132 attempt 1/10 2016-07-01 07:06:19,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fdcee57b4e4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 07:06:19,504 unpacking tar archive at: mozilla-central-fdcee57b4e4f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725310 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:19.486893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:19.487227) ========= script_repo_revision: fdcee57b4e4f66a82831ab01e61500da98a858e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:19.487700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:19.488020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:06:19.499641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-01 07:06:19.499953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:19 INFO - MultiFileLogger online at 20160701 07:06:19 in /builds/slave/test 07:06:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:06:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:19 INFO - {'append_to_log': False, 07:06:19 INFO - 'base_work_dir': '/builds/slave/test', 07:06:19 INFO - 'blob_upload_branch': 'Firefox', 07:06:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:19 INFO - 'branch': 'Firefox', 07:06:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:19 INFO - 'config_files': ('talos/linux_config.py',), 07:06:19 INFO - 'default_actions': ('clobber', 07:06:19 INFO - 'read-buildbot-config', 07:06:19 INFO - 'download-and-extract', 07:06:19 INFO - 'populate-webroot', 07:06:19 INFO - 'create-virtualenv', 07:06:19 INFO - 'install', 07:06:19 INFO - 'run-tests'), 07:06:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:19 INFO - 'download_minidump_stackwalk': True, 07:06:19 INFO - 'download_symbols': 'ondemand', 07:06:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:19 INFO - 'installer_path': 'installer.exe', 07:06:19 INFO - 'log_level': 'info', 07:06:19 INFO - 'log_name': 'talos', 07:06:19 INFO - 'log_to_console': True, 07:06:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:19 INFO - 'opt_config_files': (), 07:06:19 INFO - 'pip_index': False, 07:06:19 INFO - 'sps_profile': False, 07:06:19 INFO - 'sps_profile_interval': 0, 07:06:19 INFO - 'suite': 'dromaeojs-e10s', 07:06:19 INFO - 'system_bits': '32', 07:06:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:19 INFO - 'title': 'talos-linux64-ix-061', 07:06:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:19 INFO - 'use_talos_json': True, 07:06:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:19 INFO - 'work_dir': 'build'} 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running clobber step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: clobber 07:06:19 INFO - rmtree: /builds/slave/test/build 07:06:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:20 INFO - Running post-action listener: _resource_record_post_action 07:06:20 INFO - ##### 07:06:20 INFO - ##### Finished clobber step (success) 07:06:20 INFO - ##### 07:06:20 INFO - ##### 07:06:20 INFO - ##### Running read-buildbot-config step. 07:06:20 INFO - ##### 07:06:20 INFO - Running pre-action listener: _resource_record_pre_action 07:06:20 INFO - Running main action method: read_buildbot_config 07:06:20 INFO - Using buildbot properties: 07:06:20 INFO - { 07:06:20 INFO - "project": "", 07:06:20 INFO - "product": "firefox", 07:06:20 INFO - "script_repo_revision": "production", 07:06:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:06:20 INFO - "repository": "", 07:06:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:06:20 INFO - "buildid": "20160701043024", 07:06:20 INFO - "pgo_build": "True", 07:06:20 INFO - "basedir": "/builds/slave/test", 07:06:20 INFO - "buildnumber": 75, 07:06:20 INFO - "slavename": "talos-linux64-ix-061", 07:06:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:06:20 INFO - "platform": "ubuntu64_hw", 07:06:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:06:20 INFO - "branch": "mozilla-central", 07:06:20 INFO - "repo_path": "mozilla-central", 07:06:20 INFO - "revision": "fdcee57b4e4f66a82831ab01e61500da98a858e8", 07:06:20 INFO - "stage_platform": "linux64-pgo", 07:06:20 INFO - "builduid": "99e80d248f374e959f5454b14421704c", 07:06:20 INFO - "slavebuilddir": "test" 07:06:20 INFO - } 07:06:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:06:20 INFO - Running post-action listener: _resource_record_post_action 07:06:20 INFO - ##### 07:06:20 INFO - ##### Finished read-buildbot-config step (success) 07:06:20 INFO - ##### 07:06:20 INFO - ##### 07:06:20 INFO - ##### Running download-and-extract step. 07:06:20 INFO - ##### 07:06:20 INFO - Running pre-action listener: _resource_record_pre_action 07:06:20 INFO - Running main action method: download_and_extract 07:06:20 INFO - mkdir: /builds/slave/test/build/tests 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:20 INFO - https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:06:21 INFO - Downloaded 1361 bytes. 07:06:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:06:21 INFO - Using the following test package requirements: 07:06:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'jsshell-linux-x86_64.zip'], 07:06:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:21 INFO - https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:06:22 INFO - Downloaded 24270038 bytes. 07:06:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:06:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:06:24 INFO - Return code: 0 07:06:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:24 INFO - https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:06:28 INFO - Downloaded 24270038 bytes. 07:06:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:06:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:06:30 INFO - Return code: 0 07:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:30 INFO - https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:06:31 INFO - Downloaded 14405242 bytes. 07:06:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:06:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:06:31 INFO - Return code: 0 07:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:31 INFO - https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:06:33 INFO - Downloaded 60339154 bytes. 07:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:33 INFO - mkdir: /builds/slave/test/properties 07:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:33 INFO - Contents: 07:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:06:33 INFO - Running post-action listener: _resource_record_post_action 07:06:33 INFO - Running post-action listener: set_extra_try_arguments 07:06:33 INFO - ##### 07:06:33 INFO - ##### Finished download-and-extract step (success) 07:06:33 INFO - ##### 07:06:33 INFO - ##### 07:06:33 INFO - ##### Running populate-webroot step. 07:06:33 INFO - ##### 07:06:33 INFO - Running pre-action listener: _resource_record_pre_action 07:06:33 INFO - Running main action method: populate_webroot 07:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:33 INFO - '--tppagecycles', 07:06:33 INFO - '7'], 07:06:33 INFO - 'tests': ['tsvgm']}}, 07:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['damp', 'tps']}, 07:06:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'tests': ['damp', 'tps']}, 07:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['dromaeo_dom']}, 07:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['basic_compositor_video']}, 07:06:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['a11yr', 07:06:33 INFO - 'ts_paint', 07:06:33 INFO - 'tpaint', 07:06:33 INFO - 'sessionrestore', 07:06:33 INFO - 'sessionrestore_no_auto_restore', 07:06:33 INFO - 'tabpaint']}, 07:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['tsvgx', 07:06:33 INFO - 'tsvgr_opacity', 07:06:33 INFO - 'tart', 07:06:33 INFO - 'tscrollx', 07:06:33 INFO - 'cart']}, 07:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:33 INFO - 'tsvgr_opacity', 07:06:33 INFO - 'tart', 07:06:33 INFO - 'tscrollx', 07:06:33 INFO - 'cart']}, 07:06:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'talos_options': ['--disable-e10s'], 07:06:33 INFO - 'tests': ['tp5o']}, 07:06:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'tests': ['tp5o']}, 07:06:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'talos_options': ['--disable-e10s', 07:06:33 INFO - '--xperf_path', 07:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:33 INFO - 'tests': ['tp5n']}, 07:06:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:33 INFO - 'talos_options': ['--xperf_path', 07:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:33 INFO - 'tests': ['tp5n']}}, 07:06:33 INFO - 'talos.zip': {'path': '', 07:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:33 INFO - Running post-action listener: _resource_record_post_action 07:06:33 INFO - ##### 07:06:33 INFO - ##### Finished populate-webroot step (success) 07:06:33 INFO - ##### 07:06:33 INFO - ##### 07:06:33 INFO - ##### Running create-virtualenv step. 07:06:33 INFO - ##### 07:06:33 INFO - Running pre-action listener: _resource_record_pre_action 07:06:33 INFO - Running main action method: create_virtualenv 07:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:34 INFO - Using real prefix '/usr' 07:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:36 INFO - Installing pip.................done. 07:06:36 INFO - Return code: 0 07:06:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 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 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:36 INFO - Using env: {'DISPLAY': ':0', 07:06:36 INFO - 'HOME': '/home/cltbld', 07:06:36 INFO - 'LANG': 'en_US.UTF-8', 07:06:36 INFO - 'LANGUAGE': 'en_US:en', 07:06:36 INFO - 'LOGNAME': 'cltbld', 07:06:36 INFO - 'MAIL': '/var/mail/cltbld', 07:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:36 INFO - 'MOZ_NO_REMOTE': '1', 07:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:36 INFO - 'NO_EM_RESTART': '1', 07:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:36 INFO - 'PWD': '/builds/slave/test', 07:06:36 INFO - 'SHELL': '/bin/bash', 07:06:36 INFO - 'SHLVL': '1', 07:06:36 INFO - 'TERM': 'linux', 07:06:36 INFO - 'TMOUT': '86400', 07:06:36 INFO - 'USER': 'cltbld', 07:06:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:36 INFO - '_': '/tools/buildbot/bin/python'} 07:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:06:36 INFO - Cleaning up... 07:06:36 INFO - Return code: 0 07:06:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 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 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:36 INFO - Using env: {'DISPLAY': ':0', 07:06:36 INFO - 'HOME': '/home/cltbld', 07:06:36 INFO - 'LANG': 'en_US.UTF-8', 07:06:36 INFO - 'LANGUAGE': 'en_US:en', 07:06:36 INFO - 'LOGNAME': 'cltbld', 07:06:36 INFO - 'MAIL': '/var/mail/cltbld', 07:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:36 INFO - 'MOZ_NO_REMOTE': '1', 07:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:36 INFO - 'NO_EM_RESTART': '1', 07:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:36 INFO - 'PWD': '/builds/slave/test', 07:06:36 INFO - 'SHELL': '/bin/bash', 07:06:36 INFO - 'SHLVL': '1', 07:06:36 INFO - 'TERM': 'linux', 07:06:36 INFO - 'TMOUT': '86400', 07:06:36 INFO - 'USER': 'cltbld', 07:06:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:36 INFO - '_': '/tools/buildbot/bin/python'} 07:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:36 INFO - Downloading/unpacking psutil>=3.1.1 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:38 INFO - Installing collected packages: psutil 07:06:38 INFO - Running setup.py install for psutil 07:06:39 INFO - building 'psutil._psutil_linux' extension 07:06:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:06:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:06:39 INFO - building 'psutil._psutil_posix' extension 07:06:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:06:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:39 INFO - Successfully installed psutil 07:06:39 INFO - Cleaning up... 07:06:39 INFO - Return code: 0 07:06:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:06:39 INFO - Using env: {'DISPLAY': ':0', 07:06:39 INFO - 'HOME': '/home/cltbld', 07:06:39 INFO - 'LANG': 'en_US.UTF-8', 07:06:39 INFO - 'LANGUAGE': 'en_US:en', 07:06:39 INFO - 'LOGNAME': 'cltbld', 07:06:39 INFO - 'MAIL': '/var/mail/cltbld', 07:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:39 INFO - 'MOZ_NO_REMOTE': '1', 07:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:39 INFO - 'NO_EM_RESTART': '1', 07:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:39 INFO - 'PWD': '/builds/slave/test', 07:06:39 INFO - 'SHELL': '/bin/bash', 07:06:39 INFO - 'SHLVL': '1', 07:06:39 INFO - 'TERM': 'linux', 07:06:39 INFO - 'TMOUT': '86400', 07:06:39 INFO - 'USER': 'cltbld', 07:06:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:39 INFO - '_': '/tools/buildbot/bin/python'} 07:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:41 INFO - Installing collected packages: mozsystemmonitor 07:06:41 INFO - Running setup.py install for mozsystemmonitor 07:06:41 INFO - Successfully installed mozsystemmonitor 07:06:41 INFO - Cleaning up... 07:06:41 INFO - Return code: 0 07:06:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:06:41 INFO - Using env: {'DISPLAY': ':0', 07:06:41 INFO - 'HOME': '/home/cltbld', 07:06:41 INFO - 'LANG': 'en_US.UTF-8', 07:06:41 INFO - 'LANGUAGE': 'en_US:en', 07:06:41 INFO - 'LOGNAME': 'cltbld', 07:06:41 INFO - 'MAIL': '/var/mail/cltbld', 07:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:41 INFO - 'MOZ_NO_REMOTE': '1', 07:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:41 INFO - 'NO_EM_RESTART': '1', 07:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:41 INFO - 'PWD': '/builds/slave/test', 07:06:41 INFO - 'SHELL': '/bin/bash', 07:06:41 INFO - 'SHLVL': '1', 07:06:41 INFO - 'TERM': 'linux', 07:06:41 INFO - 'TMOUT': '86400', 07:06:41 INFO - 'USER': 'cltbld', 07:06:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:41 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:42 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:44 INFO - warning: no files found matching '*.txt' 07:06:44 INFO - no previously-included directories found matching 'build' 07:06:44 INFO - no previously-included directories found matching 'dist' 07:06:44 INFO - no previously-included directories found matching '.git*' 07:06:44 INFO - Installing collected packages: jsonschema, functools32 07:06:44 INFO - Running setup.py install for functools32 07:06:44 INFO - warning: no files found matching '*.txt' 07:06:44 INFO - no previously-included directories found matching 'build' 07:06:44 INFO - no previously-included directories found matching 'dist' 07:06:44 INFO - no previously-included directories found matching '.git*' 07:06:44 INFO - Successfully installed jsonschema functools32 07:06:44 INFO - Cleaning up... 07:06:44 INFO - Return code: 0 07:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:44 INFO - Using env: {'DISPLAY': ':0', 07:06:44 INFO - 'HOME': '/home/cltbld', 07:06:44 INFO - 'LANG': 'en_US.UTF-8', 07:06:44 INFO - 'LANGUAGE': 'en_US:en', 07:06:44 INFO - 'LOGNAME': 'cltbld', 07:06:44 INFO - 'MAIL': '/var/mail/cltbld', 07:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:44 INFO - 'MOZ_NO_REMOTE': '1', 07:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:44 INFO - 'NO_EM_RESTART': '1', 07:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:44 INFO - 'PWD': '/builds/slave/test', 07:06:44 INFO - 'SHELL': '/bin/bash', 07:06:44 INFO - 'SHLVL': '1', 07:06:44 INFO - 'TERM': 'linux', 07:06:44 INFO - 'TMOUT': '86400', 07:06:44 INFO - 'USER': 'cltbld', 07:06:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:44 INFO - '_': '/tools/buildbot/bin/python'} 07:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:47 INFO - Downloading docopt-0.6.1.tar.gz 07:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:47 INFO - Running setup.py install for blobuploader 07:06:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:47 INFO - Running setup.py install for requests 07:06:47 INFO - Running setup.py install for docopt 07:06:47 INFO - Successfully installed blobuploader requests docopt 07:06:47 INFO - Cleaning up... 07:06:47 INFO - Return code: 0 07:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:47 INFO - Using env: {'DISPLAY': ':0', 07:06:47 INFO - 'HOME': '/home/cltbld', 07:06:47 INFO - 'LANG': 'en_US.UTF-8', 07:06:47 INFO - 'LANGUAGE': 'en_US:en', 07:06:47 INFO - 'LOGNAME': 'cltbld', 07:06:47 INFO - 'MAIL': '/var/mail/cltbld', 07:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:47 INFO - 'MOZ_NO_REMOTE': '1', 07:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:47 INFO - 'NO_EM_RESTART': '1', 07:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:47 INFO - 'PWD': '/builds/slave/test', 07:06:47 INFO - 'SHELL': '/bin/bash', 07:06:47 INFO - 'SHLVL': '1', 07:06:47 INFO - 'TERM': 'linux', 07:06:47 INFO - 'TMOUT': '86400', 07:06:47 INFO - 'USER': 'cltbld', 07:06:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:47 INFO - '_': '/tools/buildbot/bin/python'} 07:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:48 INFO - Running setup.py (path:/tmp/pip-KUX6qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:48 INFO - Running setup.py (path:/tmp/pip-YrSnuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:48 INFO - Running setup.py (path:/tmp/pip-ruR4wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:48 INFO - Running setup.py (path:/tmp/pip-lg122y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:48 INFO - Running setup.py (path:/tmp/pip-LE7ZDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:48 INFO - Running setup.py (path:/tmp/pip-lxL7A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:48 INFO - Running setup.py (path:/tmp/pip-eSPtOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:48 INFO - Running setup.py (path:/tmp/pip-Uc5P83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:48 INFO - Running setup.py (path:/tmp/pip-9QxV7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:48 INFO - Running setup.py (path:/tmp/pip-EctDeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:48 INFO - Running setup.py (path:/tmp/pip-LEGm3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:48 INFO - Running setup.py (path:/tmp/pip-EooTKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:48 INFO - Running setup.py (path:/tmp/pip-fT7KRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:49 INFO - Running setup.py (path:/tmp/pip-fAs5Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:49 INFO - Running setup.py (path:/tmp/pip-KxTpA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:49 INFO - Running setup.py (path:/tmp/pip-SG3FVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:49 INFO - Running setup.py (path:/tmp/pip-06U2ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:49 INFO - Running setup.py install for manifestparser 07:06:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Running setup.py install for mozcrash 07:06:49 INFO - Running setup.py install for mozdebug 07:06:49 INFO - Running setup.py install for mozdevice 07:06:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Running setup.py install for mozfile 07:06:49 INFO - Running setup.py install for mozhttpd 07:06:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Running setup.py install for mozinfo 07:06:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for mozInstall 07:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for mozleak 07:06:50 INFO - Running setup.py install for mozlog 07:06:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for moznetwork 07:06:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for mozprocess 07:06:50 INFO - Running setup.py install for mozprofile 07:06:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for mozrunner 07:06:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:50 INFO - Running setup.py install for mozscreenshot 07:06:50 INFO - Running setup.py install for moztest 07:06:51 INFO - Running setup.py install for mozversion 07:06:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:51 INFO - Cleaning up... 07:06:51 INFO - Return code: 0 07:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:51 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 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:51 INFO - Using env: {'DISPLAY': ':0', 07:06:51 INFO - 'HOME': '/home/cltbld', 07:06:51 INFO - 'LANG': 'en_US.UTF-8', 07:06:51 INFO - 'LANGUAGE': 'en_US:en', 07:06:51 INFO - 'LOGNAME': 'cltbld', 07:06:51 INFO - 'MAIL': '/var/mail/cltbld', 07:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:51 INFO - 'MOZ_NO_REMOTE': '1', 07:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:51 INFO - 'NO_EM_RESTART': '1', 07:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:51 INFO - 'PWD': '/builds/slave/test', 07:06:51 INFO - 'SHELL': '/bin/bash', 07:06:51 INFO - 'SHLVL': '1', 07:06:51 INFO - 'TERM': 'linux', 07:06:51 INFO - 'TMOUT': '86400', 07:06:51 INFO - 'USER': 'cltbld', 07:06:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:51 INFO - '_': '/tools/buildbot/bin/python'} 07:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:51 INFO - Running setup.py (path:/tmp/pip-eh4TOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:51 INFO - Running setup.py (path:/tmp/pip-AKzisT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:51 INFO - Running setup.py (path:/tmp/pip-RjD048-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:51 INFO - Running setup.py (path:/tmp/pip-Zr5GWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:51 INFO - Running setup.py (path:/tmp/pip-ywNtKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:51 INFO - Running setup.py (path:/tmp/pip-rEPxUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:51 INFO - Running setup.py (path:/tmp/pip-YmmHBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:51 INFO - Running setup.py (path:/tmp/pip-CMbe0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:51 INFO - Running setup.py (path:/tmp/pip-cKL16N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:52 INFO - Running setup.py (path:/tmp/pip-r19FZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:52 INFO - Running setup.py (path:/tmp/pip-MGDckF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:52 INFO - Running setup.py (path:/tmp/pip-WXsNdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:52 INFO - Running setup.py (path:/tmp/pip-0gkVay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:52 INFO - Running setup.py (path:/tmp/pip-a1AFoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:52 INFO - Running setup.py (path:/tmp/pip-kX64V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:52 INFO - Running setup.py (path:/tmp/pip-h6e2ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:52 INFO - Running setup.py (path:/tmp/pip-oe6MEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:54 INFO - Downloading blessings-1.6.tar.gz 07:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:54 INFO - Installing collected packages: blessings 07:06:54 INFO - Running setup.py install for blessings 07:06:54 INFO - Successfully installed blessings 07:06:54 INFO - Cleaning up... 07:06:54 INFO - Return code: 0 07:06:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:54 INFO - Reading from file tmpfile_stdout 07:06:54 INFO - Current package versions: 07:06:54 INFO - argparse == 1.2.1 07:06:54 INFO - blessings == 1.6 07:06:54 INFO - blobuploader == 1.2.4 07:06:54 INFO - docopt == 0.6.1 07:06:54 INFO - functools32 == 3.2.3-2 07:06:54 INFO - jsonschema == 2.5.1 07:06:54 INFO - manifestparser == 1.1 07:06:54 INFO - mozInstall == 1.12 07:06:54 INFO - mozcrash == 0.17 07:06:54 INFO - mozdebug == 0.1 07:06:54 INFO - mozdevice == 0.48 07:06:54 INFO - mozfile == 1.2 07:06:54 INFO - mozhttpd == 0.7 07:06:54 INFO - mozinfo == 0.9 07:06:54 INFO - mozleak == 0.1 07:06:54 INFO - mozlog == 3.2 07:06:54 INFO - moznetwork == 0.27 07:06:54 INFO - mozprocess == 0.22 07:06:54 INFO - mozprofile == 0.28 07:06:54 INFO - mozrunner == 6.11 07:06:54 INFO - mozscreenshot == 0.1 07:06:54 INFO - mozsystemmonitor == 0.3 07:06:54 INFO - moztest == 0.7 07:06:54 INFO - mozversion == 1.4 07:06:54 INFO - psutil == 3.1.1 07:06:54 INFO - requests == 1.2.3 07:06:54 INFO - wsgiref == 0.1.2 07:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:54 INFO - Using env: {'DISPLAY': ':0', 07:06:54 INFO - 'HOME': '/home/cltbld', 07:06:54 INFO - 'LANG': 'en_US.UTF-8', 07:06:54 INFO - 'LANGUAGE': 'en_US:en', 07:06:54 INFO - 'LOGNAME': 'cltbld', 07:06:54 INFO - 'MAIL': '/var/mail/cltbld', 07:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:54 INFO - 'MOZ_NO_REMOTE': '1', 07:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:54 INFO - 'NO_EM_RESTART': '1', 07:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:54 INFO - 'PWD': '/builds/slave/test', 07:06:54 INFO - 'SHELL': '/bin/bash', 07:06:54 INFO - 'SHLVL': '1', 07:06:54 INFO - 'TERM': 'linux', 07:06:54 INFO - 'TMOUT': '86400', 07:06:54 INFO - 'USER': 'cltbld', 07:06:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:54 INFO - '_': '/tools/buildbot/bin/python'} 07:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:55 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:55 INFO - Using env: {'DISPLAY': ':0', 07:06:55 INFO - 'HOME': '/home/cltbld', 07:06:55 INFO - 'LANG': 'en_US.UTF-8', 07:06:55 INFO - 'LANGUAGE': 'en_US:en', 07:06:55 INFO - 'LOGNAME': 'cltbld', 07:06:55 INFO - 'MAIL': '/var/mail/cltbld', 07:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:55 INFO - 'MOZ_NO_REMOTE': '1', 07:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:55 INFO - 'NO_EM_RESTART': '1', 07:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:55 INFO - 'PWD': '/builds/slave/test', 07:06:55 INFO - 'SHELL': '/bin/bash', 07:06:55 INFO - 'SHLVL': '1', 07:06:55 INFO - 'TERM': 'linux', 07:06:55 INFO - 'TMOUT': '86400', 07:06:55 INFO - 'USER': 'cltbld', 07:06:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:55 INFO - '_': '/tools/buildbot/bin/python'} 07:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:55 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Running post-action listener: _resource_record_post_action 07:06:55 INFO - Running post-action listener: _start_resource_monitoring 07:06:55 INFO - Starting resource monitoring. 07:06:55 INFO - ##### 07:06:55 INFO - ##### Finished create-virtualenv step (success) 07:06:55 INFO - ##### 07:06:55 INFO - ##### 07:06:55 INFO - ##### Running install step. 07:06:55 INFO - ##### 07:06:55 INFO - Running pre-action listener: _resource_record_pre_action 07:06:55 INFO - Running main action method: install 07:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:55 INFO - Reading from file tmpfile_stdout 07:06:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:55 INFO - Reading from file tmpfile_stdout 07:06:55 INFO - Output received: 07:06:55 INFO - Usage: mozinstall [options] installer 07:06:55 INFO - Options: 07:06:55 INFO - -h, --help show this help message and exit 07:06:55 INFO - -d DEST, --destination=DEST 07:06:55 INFO - Directory to install application into. [default: 07:06:55 INFO - "/builds/slave/test"] 07:06:55 INFO - --app=APP Application being installed. [default: firefox] 07:06:55 INFO - mkdir: /builds/slave/test/build/application 07:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:07:12 INFO - Reading from file tmpfile_stdout 07:07:12 INFO - Output received: 07:07:12 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:12 INFO - Running post-action listener: _resource_record_post_action 07:07:12 INFO - ##### 07:07:12 INFO - ##### Finished install step (success) 07:07:12 INFO - ##### 07:07:12 INFO - ##### 07:07:12 INFO - ##### Running run-tests step. 07:07:12 INFO - ##### 07:07:12 INFO - Running pre-action listener: _resource_record_pre_action 07:07:12 INFO - Running main action method: run_tests 07:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:12 INFO - Python 2.7.3 07:07:12 INFO - Return code: 0 07:07:12 INFO - grabbing minidump binary from tooltool 07:07: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')]} 07:07:12 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 0x22683b0>, '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 0x22692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2269740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:07:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:07:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:07:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:12 INFO - Return code: 0 07:07:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:07:12 INFO - Using env: {'DISPLAY': ':0', 07:07:12 INFO - 'HOME': '/home/cltbld', 07:07:12 INFO - 'LANG': 'en_US.UTF-8', 07:07:12 INFO - 'LANGUAGE': 'en_US:en', 07:07:12 INFO - 'LOGNAME': 'cltbld', 07:07:12 INFO - 'MAIL': '/var/mail/cltbld', 07:07:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:12 INFO - 'MOZ_NO_REMOTE': '1', 07:07:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:12 INFO - 'NO_EM_RESTART': '1', 07:07:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:12 INFO - 'PWD': '/builds/slave/test', 07:07:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:12 INFO - 'SHELL': '/bin/bash', 07:07:12 INFO - 'SHLVL': '1', 07:07:12 INFO - 'TERM': 'linux', 07:07:12 INFO - 'TMOUT': '86400', 07:07:12 INFO - 'USER': 'cltbld', 07:07:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542', 07:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:12 INFO - '_': '/tools/buildbot/bin/python'} 07:07:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:07:13 INFO - mozversion application_buildid: 20160701043024 07:07:13 INFO - mozversion application_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 07:07:13 INFO - mozversion application_display_name: Nightly 07:07:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:13 INFO - mozversion application_name: Firefox 07:07:13 INFO - mozversion application_remotingname: firefox 07:07:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:13 INFO - mozversion application_vendor: Mozilla 07:07:13 INFO - mozversion application_version: 50.0a1 07:07:13 INFO - mozversion platform_buildid: 20160701043024 07:07:13 INFO - mozversion platform_changeset: fdcee57b4e4f66a82831ab01e61500da98a858e8 07:07:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:13 INFO - mozversion platform_version: 50.0a1 07:07:13 INFO - using testdate: 1467382033 07:07:13 INFO - actual date: 1467382033 07:07:13 INFO - starting webserver on 'localhost:39670' 07:07:13 INFO - SUITE-START | Running 2 tests 07:07:13 INFO - TEST-START | dromaeo_css 07:07:13 INFO - operating with platform_type : linux_ 07:07:13 INFO - Initialising browser for dromaeo_css test... 07:07:13 INFO - TEST-INFO | started process 7550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhMVfT/profile http://localhost:39670/getInfo.html) 07:07:18 INFO - PROCESS | 7550 | __metrics Screen width/height:1600/1200 07:07:18 INFO - PROCESS | 7550 | colorDepth:24 07:07:18 INFO - PROCESS | 7550 | Browser inner width/height: 1024/697 07:07:18 INFO - PROCESS | 7550 | __metrics 07:07:18 ERROR - PROCESS | 7550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:07:19 INFO - TEST-INFO | 7550: exit 0 07:07:19 INFO - Browser initialized. 07:07:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:19 INFO - TEST-INFO | started process 7671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhMVfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:31 INFO - PROCESS | 7671 | RSS: Main: 168423424 07:07:31 INFO - PROCESS | 7671 | 07:08:21 INFO - PROCESS | 7671 | 1467382101107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:10:29 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39670/tests/dromaeo/cssquery-ext.html) 07:10:30 INFO - PROCESS | 7671 | RSS: Main: 171802624 07:10:30 INFO - PROCESS | 7671 | 07:13:32 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-ext.html (next: http://localhost:39670/tests/dromaeo/cssquery-jquery.html) 07:13:33 INFO - PROCESS | 7671 | RSS: Main: 169267200 07:13:33 INFO - PROCESS | 7671 | 07:16:35 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39670/tests/dromaeo/cssquery-mootools.html) 07:16:36 INFO - PROCESS | 7671 | RSS: Main: 172781568 07:16:36 INFO - PROCESS | 7671 | 07:19:37 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39670/tests/dromaeo/cssquery-prototype.html) 07:19:38 INFO - PROCESS | 7671 | RSS: Main: 167972864 07:19:38 INFO - PROCESS | 7671 | 07:22:40 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39670/tests/dromaeo/cssquery-yui.html) 07:22:41 INFO - PROCESS | 7671 | RSS: Main: 169902080 07:22:41 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:39670/tests/dromaeo/cssquery-yui.html (next: http://localhost:39670/tests/dromaeo/cssquery-dojo.html) 07:25:44 INFO - PROCESS | 7671 | RSS: Main: 171470848 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | __start_tp_report 07:25:44 INFO - PROCESS | 7671 | _x_x_mozilla_page_load 07:25:44 INFO - PROCESS | 7671 | _x_x_mozilla_page_load_details 07:25:44 INFO - PROCESS | 7671 | |i|pagename|runs| 07:25:44 INFO - PROCESS | 7671 | |0;dojo.html;3154.6056742907135;3161.2887100402413;3201.6638252983435;3217.54954306397;3231.176050107223;5481.479259470349;5495.697736624489;5498.505134537891;5600.5799565032585;5606.971965140179;5440.211169380437;5475.479829416209;5513.669179849212;5514.36584792749;5563.109902415615;4980.178270585358;5040.722760248185;5079.79680812767;5154.098032844256;5179.715115668637;784.4593347441441;4851.927221091686;4976.054549635558;4983.875403114915;4989.226669866159;4998.700077995314;5009.649324547247;5038.974805125969;5042.520960508764;5048.394192696863;5056.974715126437;5058.570021548173;5067.113255180328;5085.644004919657;5087.796488140507;4938.407391113054;4974.204127339608;4991.101601711691;5009;5011.373578302712;5486.204500347467;5521.668699878021;5527.695976721278;5544.63959842613;5597.552195824365;5776.913346299809;5884;5897.587168898179;5902.498287645555;5930.733117009745;6009.489193418564;6042.697865106771;6079.665618390986;6090.5736598438125;6110.7861224856915;5662.745176467028;5671.971640141773;5674.971625141848;5677.772889084432;5687.459691329317;5954.345022047572;5957.970210148921;5984.072468767348;6155.907661385083;6156.907646385308;5826.126081087786;5827.446392592697;5827.79602713903;5835.79574714883;5844.386339434383;5989.79035733756;5992.730327135289;5996.910046349309;6006.819795406145;6013;5823.213866128103;5846.561507886926;5858.443447872445;5915.704214789243;5989.1914591529585;5844.883102338014;5849.824505264849;5874.73563689635;5889.263842019747;5897.292324921037;4393.736375817397;4516.23224051912;4517.141743068806;4520.412346394947;4569.086182763394;3955.6835453163676;3982.681385489212;3990.4812374391145;4027.3556231003486;4033.858814941463;5560.4161563036105;5654.9151762723595;5676.262085928803;5729.341125770507;5780.566457515619;5888.587798854125;6017.819465416044;6035.155078289043;6039.275286965592;6046.425589569072;5616.157576363578;5645.576581756384;5656.745446454919;5718.085106382959;5725.656460612377;5103.87240318995;5105;5126.53861152498;5144.717040562805;5174.275601415805;6009.879802403927;6131.754729810757;6168.136460895478;6181.96909015461;6185.659788711664;5963.105534169736;6045.78839740607;6047.334793172836;6047.969760151171;6093.786717464867;6189.35011823752;6198.380161983766;6205.100260462117;6219.626822390671;6247.5939063960695;5744.856378590569;5829.679367634821;5839.824805255849;5884.411558844081;5893.734781934909;5948.940510594839;5956.106584012433;5977.103434484862;6003.549733769897;6026.186464827192;5769.79805706815;5813.3605303417435;5853.356130825691;5878.088896221093;5878.353381127987;5640.492355688008;5765.077587585966;5771.7402716877;5803.216565763737;5809.593328466966;5717.8570535736935;5730.684812335361;5746.9712651436475;5755.366909639853;5758.971205143947;5846.210761547137;5851.590388672922;5860.531157507304;5896.705164741831;5906.586538942232;5612.186232996274;5681.8863622726485;5696.515796157373;5696.629719068247;5797.681127538026 07:25:44 INFO - PROCESS | 7671 | |1;ext.html;574.2104606166521;611.8317462697759;616.2081724983394;629.4303655192051;654.7119267522293;40187.79906100469;41211;45152;45162.09675806486;45183.77408112963;45170;45614.08771824562;45704.54295457045;45723.31415028769;45811.08377832449;8885.511296878669;9030.00669926311;9031.142041506046;9039.457632542035;9049.276057915384;9030.954845225764;9045.909540904573;9063.41087829289;9098.044705305947;9100.226480749112;9133.908660913405;9179;9187.127222913847;9189.954050229739;9209.539523023823;9053;9055.864162037575;9118.088191180863;9131.908680913173;9133.954330228305;8999.685011024583;9020.77448063797;9051;9075.591598378089;9078.182963533314;32942;43015.35476967848;43041.35437968433;43430.13139737188;43460.56539434628;3443.7933723976644;3456.187795867969;3558.928821423583;3761.153740408386;3776.244751049801;31971.200719981953;32012.199695007577;32646.83676581602;32804.179895502806;33133;4103.097318589906;4127.442795222637;4161.292580261363;4205.3271476563605;4341.45731783527;312667.4366628175;313004;316516;317250;318653;36775.632243677224;37222.255554888754;37271;37392;37488.25023499515;39194.80402597969;39627;39750.20499589992;39766.00584985399;39800;15363.615909602126;15475.845241547666;15492.690146197014;15511;15556.22218889051;12422.316772577415;12529.498820047096;12542.749145017231;12631.557895473798;12680.429380677708;9018.819623607491;9047.823782908179;9090.772730681785;9102.635894564275;9168.541572921327;3468.2543253200683;3494.895153145359;3515.3320869035315;3522.4716292556323;3556.3065202285306;944.7354740672623;1087.2932593813925;1116.0402054233352;1130.8303754436736;1175.5474142455216;32942.34115317728;33164;33194.170145746066;33423.498647520304;33797.83101084479;1096.4079397125622;1127.425013243252;1187.1155988788407;1221.4137214137263;1265.367316341829;17455.38906138279;17460;17504.824951750576;17601.11994400275;17603.55991100233;586330;586720;588582;589816.5091745396;591071;58770;58893.411065889646;59221.40778592159;59332.406675933555;59409.702951484964;1274.5857596281246;1335.5525898823807;1350.1021820489264;1357.4027427931678;1375.3810785146725;30956.380872382877;32324.353512929138;32696.673033269362;32841.50737738888;32897.712868284834;52135.739321303154;52444.47555524549;52858.735706321226;52876.735616321675;52919.735401322745;461917;464692;465571;465831;466322;29397.26506837346;30019;30165.09504714862;30445.695543044287;30474.390512190075;49318.75340623274;49639.503604964935;50304.24543631775;50330.748346258035;50861.74569127279;40542.39186412147;42594.935126622084;42749.870015598324;42823.78588107164;43045.3543196846;42650.360244596974;42652.57347426486;42814.50149244761;42842.57157428386;42983.570164297955;41296;41687.374689379074;41834.163316734106;42502.78748606237;42504;35528;37024.25951480901;37613.623863762106;37933.620663794114;38406.23187536289;28599;28642.427151457272;29063.709362906102;29295.85352073226;29333.559996600496 07:25:44 INFO - PROCESS | 7671 | |2;jquery.html;407.64127567740405;410.9486314210724;412.5358971157448;416.10744952077795;425.2091110534407;18546.53633659159;19766.802331976676;20265.797342026577;20345;20894.37316880496;13076.73846523069;13211.207327560352;13367.264800435973;13467.191968481873;13544.864551354483;5452.83641490755;5582.720863956806;5585.944140558603;5604.85987850305;5729.255196824407;5725.856853578673;5810.3027636683655;5814.592978491507;5853.473187413132;5865.970670146643;5796.594238403313;5806.071028635419;5835.4456326649115;5845.503132233765;5920.407959204067;5765.5099316557935;5890.587658863881;5891.204687367193;5923.496502797268;5950.55370847186;5192.688438693691;5338.466153384669;5342.038433082043;5462.808801691922;5499.642523235977;14544.181977252843;14999.775003374958;15019.324130414157;15040.473583424528;15208.771868421982;2223.7998580127864;2227.231605096239;2229.710137682107;2234.084025549533;2242.1367773407355;11030.448477576088;11410.486528106256;13398.397072131778;14528.346224419927;14999.925000374928;1817.71825367067;1839.6320735852883;1882.0777818868792;1886.0663971334277;1952.6778081616517;89078.55460722654;89459.55270223672;90336;90677.54661226651;91802.54098729463;10868.402237876993;11318.660440186808;12123.636290911287;12208.206466579644;12294.20087694297;15988.520344389686;15994.200289985454;16001.599960001093;16088.436904708278;16170.353185872433;8226.259636632733;8425.325973922072;8542.145785421533;8597.226249637562;8644.135586441305;8076.515409075474;8145.125529996059;8266.380021498411;8369.288610468178;8440.704575339834;4806.399200099988;4957.677750946177;4965.950340496621;5038.496150385005;5050.141475949097;2082.427332483579;2094.3402828109097;2105.252645297901;2113.38711773587;2129.368623244468;871.538084815049;927.9953600231955;1023.4933707814531;1075.9193060520493;1125.386664267976;20564.177432902816;20751.79248207529;21039.263625773023;21074.894625526773;21114.261000864895;1012.2104758288547;1023.5496381592076;1024.8155332040155;1028.681108856242;1043.88517263101;11102.833457498144;11629.47667354971;11751.88248117525;11818.290902545874;11891.881081189078;439884;441345;463940.5241633121;465537;466160;92056;95572.52213738886;97154.51422742842;98461;98997;991.8561808537721;1029.7888932768765;1032.5405194688292;1041.245097304448;1043.0612448796144;17796.55508612295;18084.45746627603;18367.173477193825;18400.447986559888;18406.996829126478;40939.59060409358;42014;42104.78947605242;42829.287703939015;44308.33537496876;58765;59246.70376648261;62255.6887215561;62863.05705414331;63543.6822815883;9070.546472676207;9353.204977576983;9419.576119074794;9508;9592.808143837225;10349.151282368975;13934.930325348309;14449.422023118957;14480.493182738554;14508.274586270856;12580.182288151242;12596.937015314865;12631.368431578201;12663;12829.679258018625;12354.25874447536;12363.567275145328;12552;12639.620811375673;12820;8913.55432228399;9218.677346292847;9423.905760942303;9446.480443575669;12915.289659068842;13109.868901310865;13358.933205333911;13515.05394622367;13574.86425135736;13775.104618200186;13094.476220951055;13122.934385328012;13215.339233038118;13375.264360460269;13662.863371366158 07:25:44 INFO - PROCESS | 7671 | |3;mootools.html;1478.726435609412;1497.6854860479298;1658.86729061675;1811.094452773614;1832.9083545822705;7756.767296981099;8150.388720845931;8312.168783121684;8840.336974726897;8856.202941735251;8364.581770911445;8383.161683831613;8406.453580517262;8427.452215605981;8516.403851730382;2352.6823878776404;2390.760923907604;2393.796527295182;2403.3390817525146;2421.8062554995645;2406.9638955415594;2412.2763171048705;2435.476372579895;2436.4396188876567;2439.756024397555;2366.8106551475926;2391.5336509380677;2392.892319845611;2435.305937807725;2441.963370549443;2366.3729111785306;2374.6912901322803;2375.869327187004;2379.9762002380016;2398.1966041375986;2357.610994185957;2376.1683410806254;2381.618940969454;2381.8451800633075;2409.084547871815;8510.234078932865;8510.87233691489;8519;8540.44487108336;8579.742607721779;5324.92012619811;5441.455854414527;5453.318335208099;5465.726713664301;5478.808241711521;3291.1113999220074;3331.600207975034;3349.815760133192;3369.073504786179;3382.0530251529613;1132.4281237974853;1151.4588143572507;1166.8658104318026;1176.5117476247347;1183.0240051957085;11885.821712674317;11975.520979160736;11981;12001.939990299992;12024.51901923922;4788.856334309976;4791.496892826203;4907.116718990616;4973.303737476756;4979;10223.539940702687;10224.28430009907;10235.539400726986;10269.383836969806;10273.589056437659;5409.756560954766;5427.104527752956;5444.809431669952;5450.291462109901;5454.072807622713;4394.912101757947;4854.271859221145;4991.575716064175;4996.150654388763;5000.299958005882;4077.7145599807727;4144.290859680629;4184.790760461965;4234.555371685929;4246.915061698749;1338.5315139701222;1357.4027427931678;1357.8234829472106;1364.3519328319167;1380.1236215003344;838.5974732128491;923.9584218710174;934.948577828226;948.7059011706393;967.583938906277;5597.076482380443;5950.9107363389585;5976.491998180117;5986.07215881539;6188.81433556994;933.6918816790443;975.9365641233297;982.2142286171035;1002.9648962286285;1059.5496913811598;3754.155315054091;3756.4928734620476;3822.1591249924973;3929.6814879220824;3982.004498875281;10638.202134839918;10911.727206819734;11025.173112016631;11072;11092.611758588571;10828.566857325619;10914.781704365869;10923;10966.287191332538;10978.560857565768;7817.257360550852;8101.918980810116;8216.917830821616;8377.287930525852;8379.036410812834;5595.300587426572;5764.827055188351;5813.709314534341;5913.645181289136;6107.572469927062;9036.186743193144;9658.90341096608;9682.806343873224;9736.026397360207;10146.492675366055;10179.491025448846;10205.540750666387;10244.846327304947;10249.641262555775;10311.175105991353;7399.186089530255;8189.262966333059;8197.959010204911;8253.174682531699;8371.748847534584;8576.399652024547;8586.184312490303;8599.742007739778;8618.181272779077;8633.05036446003;7626.466147369631;7819.726309579138;7819.726309579138;7914.881276780968;7920.84158316842;7586.506877052974;7678.846423071619;7730.11103723079;7755.030621172354;7808.7657370278985;7221.241769614325;7223.927760722326;7232.240614735588;7232.493725439169;7316.780496585111;4786.904261914812;4939.75301234944;5035.521625445577;5071.721055341844;5081.923771143362;5116.360454943132;5144.922826157535;5179.430262671179;5199.168133098686;5231.581473482036 07:25:44 INFO - PROCESS | 7671 | |4;prototype.html;349.37636319170286;350.51278722575614;352.95411596492465;355.8878953129764;355.9123466981713;5734.569907256951;5753.769849206037;5771.913421298678;5777.306723193217;5801.274840644919;5666.773329066843;5669.319681638199;5681.431856814316;5691.516221121199;5722.227499287595;3806.471000701198;4303.203907277164;4379.737215767048;4421.624161946223;4455.198064348416;4437.977810110961;4452.577005184502;4479.9552004479865;4488.586095379961;4490.9550904491025;4437.156940181371;4453.4433195850515;4456.777161141946;4464.0179160584785;4465.6874018818535;4284.785760711952;4394.209042372372;4404.427424434835;4410.316400957857;4475.5748203920575;3938.251732170907;3941.6452519273116;3948.348522493785;3956.9010774730573;3965.325894597925;5519.448055194489;5558.166275058733;5619.466150715716;5631.943680563183;5648.576356773258;5094.541491265767;5130.204818253177;5146.893417915128;5166.870828229286;5184.6629969052265;5937.910931336033;5947.881042379171;5963.850903727398;5970.656432397871;6030.66831324277;4374.34384842273;4395.318725597537;4404.845830395952;4406.713563618355;4411.823527058914;5999.950008748451;6099.237595300588;6171.228596425447;6197.628142311431;6207.4723648489935;4367.323064924942;4400.44994375703;4401.537838526909;4409.250427427345;4414.690971631955;4396.076823867023;4413.205622987829;4425.845095421645;4454.198244316054;4457.153140903218;4931.975340123348;5087.8982420351385;5094.15946368845;5096.490350964874;5103.540681338697;5956.344802071769;5966.105084237312;5998.340182579913;6004.969975150097;6043.184170137063;1532.2491978930243;1544.6678964022565;1552.8447155284382;1555.2690235589255;1555.478914563634;932.6502561539422;981.3915372469115;994.0556471352244;998.6654470752234;1002.5889385352117;5239.502247286502;5245.895082098336;5284.867878302996;5285.762140703678;5288.439910226492;5430.782768689287;5432.619716619878;5455.263539422127;5455.954017243534;5502.514321133272;4852.976925786432;5091.345312773289;5119.436861945258;5135.97432012845;5137.6660517066275;2859.313764696458;2870.4546136234467;2896.232498387929;2908.9201221126573;2919.32855443245;5566.805161819317;5572.58205634579;5572.888542229132;5594.272744543184;5695.971520142372;5362.731863406814;5436.673799572039;5570.100929349472;5629.887402252014;5633.6619802811965;5640.0693885508435;5657;5676.858078548069;5692.28846394209;5717.4266083697685;5144.228365745168;5431.452036169672;5452.973599652231;5464.398916119303;5494.857005767673;5395.839894422718;5407.648502847303;5420.159875219348;5427.457254274541;5922.881542369215;6349.127007532697;6377.394147555975;6414;6434.485241180788;6435.839104022437;4414.933775993299;4429.734215947054;4430.291153415438;4452.821887124479;4454.910901782011;6074.119252708244;6111.602745821508;6141.539384546266;6154.907676384768;6251.187345645037;5966.3138739043825;5981.850453738692;5989.580729349078;6000.4998750312425;6004.189434426296;5618.943810561842;5974.253218347707;6034.732706131762;6065.696715164312;6090.634561926298;5863.853403664943;5881.529477641864;5925.192816191103;5925.703714814328;5936.465718085393;6036;6039.849003774765;6074.96251874063;6088.908666370096;6116.633002019893;5621.297337832771;5852.7658893643775;5911.408859114054;5917.437843404869;5920.348761636303 07:25:44 INFO - PROCESS | 7671 | |5;yui.html;761.5735188294556;804.3243675312737;835.8871552340435;843.4770442325758;847.3898792869136;14600.415983360666;15513.069215847057;15542.53372398827;15569.610759730984;15759.212039398013;15453.845461545381;15718.607034824106;15746.291416886239;15752.684946301068;15759.842401575981;793.4406243598249;800.3357213512785;812.7033632724043;814.3892080939296;815.1603848036502;824.3734761581181;835.0480452284401;845.1590667286059;845.3110714767475;846.2933450568783;871.5859966515918;871.6208449324532;872.7687162901836;878.6046279174398;879.1911441473827;864.2308345572445;870.6647940542905;872.1060912564609;872.7381785464336;872.7381785464398;635.8664680417118;636.2619361540591;636.2746469025315;636.3954243468723;636.6084857812458;15317.617059573487;15524.689506209812;15538.844611553966;15541.533753987398;15572.454964076316;15503.922480387526;15504.224788760517;15547.766783498144;15548.455804046916;15698.293576789072;13091.738165236737;13155.276459794708;13240.86759132406;13307.534236301779;13736.313184340843;3941.113249518864;3941.2511622791862;3966.5240171179353;3967.8809635710977;4092.1815636872743;87959;88080.55959720224;88324;90082;90241;11348.205625606128;11551.36467494279;11759.529618815322;12200.938995304967;12239.877601223874;19560.413187604394;19781.40655780329;19868.90065549692;19871.205151794056;19900.800991989894;8536.402451828313;8632.309415246891;8745.256653184424;8848.070952550019;8884.422512536794;4522.760646108638;4598.1033698429155;4635.907281854344;4701.976490117528;4819.012102518976;3547.733919956014;3673.797941113211;3675.9081022974638;3678.889633311005;3696.500972368696;656.8226578823691;658.2890478283442;659.6306068601599;678.4097834883585;680.2857000149822;750.9098908131059;763.6868883757633;775.3409601838392;788.3929374381809;793;9628.71113866571;9870.950645246729;10115.544800483996;10133.290669653054;10480;615.3446579392933;743.31614914279;760.4713731174331;766.2300782670717;770.3221165374434;4764.690295130806;5240.082985477527;5545.7781688732;5643;5655.208270842086;77835;103623.96376036294;128100.35949820191;129850;130612;111522;114792;114814;114879;116432;95680;100046;101585.1750391168;101658;102424;10387.584496620051;10657.25399222047;10657.893421066;10680.679579612624;10689.51897164614;48334;49087.50912490829;55289.1706624409;55976;56231.718841407164;53167.734161328946;57826;66225;78082.21917780749;79108.20891791009;12779;13123.475060997453;13359.599212023655;13368;13860.445582177003;13255;14983.775243371576;15307.387704491695;15881.205939703199;15912.124833134289;14554.854451455774;14638.341274642453;14686.840113152037;14825.92587037058;15511.37954481808;14000.369983350978;14292.85707142957;14329.283535823375;14492.637684057983;14506.709865802835;13675.658108547366;14042.578722638336;14172.291385430894;14638.634034149232;14876.181810000553;11349.659510214708;11594.044447978426;11753.588624398106;11907.464164112462;11916.702082448008;11020.901882114998;11718.125898705835;11963.234596624181;12100.334481603597;12214.877851221729 07:25:44 INFO - PROCESS | 7671 | __end_tp_report 07:25:44 INFO - PROCESS | 7671 | __start_cc_report 07:25:44 INFO - PROCESS | 7671 | _x_x_mozilla_cycle_collect,381 07:25:44 INFO - PROCESS | 7671 | __end_cc_report 07:25:44 INFO - PROCESS | 7671 | __startTimestamp1467383144452__endTimestamp 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | ------- Summary: start ------- 07:25:44 INFO - PROCESS | 7671 | Number of tests: 6 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#0] dojo.html Cycles:165 Average:5497.35 Median:5755.37 stddev:741.42 (12.9%) stddev-sans-first:720.56 07:25:44 INFO - PROCESS | 7671 | Values: 3154.6 3161.3 3201.7 3217.5 3231.2 5481.5 5495.7 5498.5 5600.6 5607.0 5440.2 5475.5 5513.7 5514.4 5563.1 4980.2 5040.7 5079.8 5154.1 5179.7 784.5 4851.9 4976.1 4983.9 4989.2 4998.7 5009.6 5039.0 5042.5 5048.4 5057.0 5058.6 5067.1 5085.6 5087.8 4938.4 4974.2 4991.1 5009.0 5011.4 5486.2 5521.7 5527.7 5544.6 5597.6 5776.9 5884.0 5897.6 5902.5 5930.7 6009.5 6042.7 6079.7 6090.6 6110.8 5662.7 5672.0 5675.0 5677.8 5687.5 5954.3 5958.0 5984.1 6155.9 6156.9 5826.1 5827.4 5827.8 5835.8 5844.4 5989.8 5992.7 5996.9 6006.8 6013.0 5823.2 5846.6 5858.4 5915.7 5989.2 5844.9 5849.8 5874.7 5889.3 5897.3 4393.7 4516.2 4517.1 4520.4 4569.1 3955.7 3982.7 3990.5 4027.4 4033.9 5560.4 5654.9 5676.3 5729.3 5780.6 5888.6 6017.8 6035.2 6039.3 6046.4 5616.2 5645.6 5656.7 5718.1 5725.7 5103.9 5105.0 5126.5 5144.7 5174.3 6009.9 6131.8 6168.1 6182.0 6185.7 5963.1 6045.8 6047.3 6048.0 6093.8 6189.4 6198.4 6205.1 6219.6 6247.6 5744.9 5829.7 5839.8 5884.4 5893.7 5948.9 5956.1 5977.1 6003.5 6026.2 5769.8 5813.4 5853.4 5878.1 5878.4 5640.5 5765.1 5771.7 5803.2 5809.6 5717.9 5730.7 5747.0 5755.4 5759.0 5846.2 5851.6 5860.5 5896.7 5906.6 5612.2 5681.9 5696.5 5696.6 5797.7 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#1] ext.html Cycles:180 Average:60419.46 Median:22728.65 stddev:125186.33 (550.8%) stddev-sans-first:125456.87 07:25:44 INFO - PROCESS | 7671 | Values: 574.2 611.8 616.2 629.4 654.7 40187.8 41211.0 45152.0 45162.1 45183.8 45170.0 45614.1 45704.5 45723.3 45811.1 8885.5 9030.0 9031.1 9039.5 9049.3 9031.0 9045.9 9063.4 9098.0 9100.2 9133.9 9179.0 9187.1 9190.0 9209.5 9053.0 9055.9 9118.1 9131.9 9134.0 8999.7 9020.8 9051.0 9075.6 9078.2 32942.0 43015.4 43041.4 43430.1 43460.6 3443.8 3456.2 3558.9 3761.2 3776.2 31971.2 32012.2 32646.8 32804.2 33133.0 4103.1 4127.4 4161.3 4205.3 4341.5 312667.4 313004.0 316516.0 317250.0 318653.0 36775.6 37222.3 37271.0 37392.0 37488.3 39194.8 39627.0 39750.2 39766.0 39800.0 15363.6 15475.8 15492.7 15511.0 15556.2 12422.3 12529.5 12542.7 12631.6 12680.4 9018.8 9047.8 9090.8 9102.6 9168.5 3468.3 3494.9 3515.3 3522.5 3556.3 944.7 1087.3 1116.0 1130.8 1175.5 32942.3 33164.0 33194.2 33423.5 33797.8 1096.4 1127.4 1187.1 1221.4 1265.4 17455.4 17460.0 17504.8 17601.1 17603.6 586330.0 586720.0 588582.0 589816.5 591071.0 58770.0 58893.4 59221.4 59332.4 59409.7 1274.6 1335.6 1350.1 1357.4 1375.4 30956.4 32324.4 32696.7 32841.5 32897.7 52135.7 52444.5 52858.7 52876.7 52919.7 461917.0 464692.0 465571.0 465831.0 466322.0 29397.3 30019.0 30165.1 30445.7 30474.4 49318.8 49639.5 50304.2 50330.7 50861.7 40542.4 42594.9 42749.9 42823.8 43045.4 42650.4 42652.6 42814.5 42842.6 42983.6 41296.0 41687.4 41834.2 42502.8 42504.0 35528.0 37024.3 37613.6 37933.6 38406.2 28599.0 28642.4 29063.7 29295.9 29333.6 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#2] jquery.html Cycles:180 Average:28626.31 Median:11613.82 stddev:75617.99 (651.1%) stddev-sans-first:75800.43 07:25:44 INFO - PROCESS | 7671 | Values: 407.6 410.9 412.5 416.1 425.2 18546.5 19766.8 20265.8 20345.0 20894.4 13076.7 13211.2 13367.3 13467.2 13544.9 5452.8 5582.7 5585.9 5604.9 5729.3 5725.9 5810.3 5814.6 5853.5 5866.0 5796.6 5806.1 5835.4 5845.5 5920.4 5765.5 5890.6 5891.2 5923.5 5950.6 5192.7 5338.5 5342.0 5462.8 5499.6 14544.2 14999.8 15019.3 15040.5 15208.8 2223.8 2227.2 2229.7 2234.1 2242.1 11030.4 11410.5 13398.4 14528.3 14999.9 1817.7 1839.6 1882.1 1886.1 1952.7 89078.6 89459.6 90336.0 90677.5 91802.5 10868.4 11318.7 12123.6 12208.2 12294.2 15988.5 15994.2 16001.6 16088.4 16170.4 8226.3 8425.3 8542.1 8597.2 8644.1 8076.5 8145.1 8266.4 8369.3 8440.7 4806.4 4957.7 4966.0 5038.5 5050.1 2082.4 2094.3 2105.3 2113.4 2129.4 871.5 928.0 1023.5 1075.9 1125.4 20564.2 20751.8 21039.3 21074.9 21114.3 1012.2 1023.5 1024.8 1028.7 1043.9 11102.8 11629.5 11751.9 11818.3 11891.9 439884.0 441345.0 463940.5 465537.0 466160.0 92056.0 95572.5 97154.5 98461.0 98997.0 991.9 1029.8 1032.5 1041.2 1043.1 17796.6 18084.5 18367.2 18400.4 18407.0 40939.6 42014.0 42104.8 42829.3 44308.3 58765.0 59246.7 62255.7 62863.1 63543.7 9070.5 9353.2 9419.6 9508.0 9592.8 10349.2 13934.9 14449.4 14480.5 14508.3 12580.2 12596.9 12631.4 12663.0 12829.7 12354.3 12363.6 12552.0 12639.6 12820.0 8913.6 9218.7 9423.9 9446.5 12915.3 13109.9 13358.9 13515.1 13574.9 13775.1 13094.5 13122.9 13215.3 13375.3 13662.9 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#3] mootools.html Cycles:180 Average:5804.00 Median:4976.15 stddev:3232.95 (65.0%) stddev-sans-first:3225.68 07:25:44 INFO - PROCESS | 7671 | Values: 1478.7 1497.7 1658.9 1811.1 1832.9 7756.8 8150.4 8312.2 8840.3 8856.2 8364.6 8383.2 8406.5 8427.5 8516.4 2352.7 2390.8 2393.8 2403.3 2421.8 2407.0 2412.3 2435.5 2436.4 2439.8 2366.8 2391.5 2392.9 2435.3 2442.0 2366.4 2374.7 2375.9 2380.0 2398.2 2357.6 2376.2 2381.6 2381.8 2409.1 8510.2 8510.9 8519.0 8540.4 8579.7 5324.9 5441.5 5453.3 5465.7 5478.8 3291.1 3331.6 3349.8 3369.1 3382.1 1132.4 1151.5 1166.9 1176.5 1183.0 11885.8 11975.5 11981.0 12001.9 12024.5 4788.9 4791.5 4907.1 4973.3 4979.0 10223.5 10224.3 10235.5 10269.4 10273.6 5409.8 5427.1 5444.8 5450.3 5454.1 4394.9 4854.3 4991.6 4996.2 5000.3 4077.7 4144.3 4184.8 4234.6 4246.9 1338.5 1357.4 1357.8 1364.4 1380.1 838.6 924.0 934.9 948.7 967.6 5597.1 5950.9 5976.5 5986.1 6188.8 933.7 975.9 982.2 1003.0 1059.5 3754.2 3756.5 3822.2 3929.7 3982.0 10638.2 10911.7 11025.2 11072.0 11092.6 10828.6 10914.8 10923.0 10966.3 10978.6 7817.3 8101.9 8216.9 8377.3 8379.0 5595.3 5764.8 5813.7 5913.6 6107.6 9036.2 9658.9 9682.8 9736.0 10146.5 10179.5 10205.5 10244.8 10249.6 10311.2 7399.2 8189.3 8198.0 8253.2 8371.7 8576.4 8586.2 8599.7 8618.2 8633.1 7626.5 7819.7 7819.7 7914.9 7920.8 7586.5 7678.8 7730.1 7755.0 7808.8 7221.2 7223.9 7232.2 7232.5 7316.8 4786.9 4939.8 5035.5 5071.7 5081.9 5116.4 5144.9 5179.4 5199.2 5231.6 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#4] prototype.html Cycles:180 Average:4893.34 Median:5444.82 stddev:1419.83 (26.1%) stddev-sans-first:1382.25 07:25:44 INFO - PROCESS | 7671 | Values: 349.4 350.5 353.0 355.9 355.9 5734.6 5753.8 5771.9 5777.3 5801.3 5666.8 5669.3 5681.4 5691.5 5722.2 3806.5 4303.2 4379.7 4421.6 4455.2 4438.0 4452.6 4480.0 4488.6 4491.0 4437.2 4453.4 4456.8 4464.0 4465.7 4284.8 4394.2 4404.4 4410.3 4475.6 3938.3 3941.6 3948.3 3956.9 3965.3 5519.4 5558.2 5619.5 5631.9 5648.6 5094.5 5130.2 5146.9 5166.9 5184.7 5937.9 5947.9 5963.9 5970.7 6030.7 4374.3 4395.3 4404.8 4406.7 4411.8 6000.0 6099.2 6171.2 6197.6 6207.5 4367.3 4400.4 4401.5 4409.3 4414.7 4396.1 4413.2 4425.8 4454.2 4457.2 4932.0 5087.9 5094.2 5096.5 5103.5 5956.3 5966.1 5998.3 6005.0 6043.2 1532.2 1544.7 1552.8 1555.3 1555.5 932.7 981.4 994.1 998.7 1002.6 5239.5 5245.9 5284.9 5285.8 5288.4 5430.8 5432.6 5455.3 5456.0 5502.5 4853.0 5091.3 5119.4 5136.0 5137.7 2859.3 2870.5 2896.2 2908.9 2919.3 5566.8 5572.6 5572.9 5594.3 5696.0 5362.7 5436.7 5570.1 5629.9 5633.7 5640.1 5657.0 5676.9 5692.3 5717.4 5144.2 5431.5 5453.0 5464.4 5494.9 5395.8 5407.6 5420.2 5427.5 5922.9 6349.1 6377.4 6414.0 6434.5 6435.8 4414.9 4429.7 4430.3 4452.8 4454.9 6074.1 6111.6 6141.5 6154.9 6251.2 5966.3 5981.9 5989.6 6000.5 6004.2 5618.9 5974.3 6034.7 6065.7 6090.6 5863.9 5881.5 5925.2 5925.7 5936.5 6036.0 6039.8 6075.0 6088.9 6116.6 5621.3 5852.8 5911.4 5917.4 5920.3 07:25:44 INFO - PROCESS | 7671 | 07:25:44 INFO - PROCESS | 7671 | [#5] yui.html Cycles:180 Average:22056.44 Median:11724.27 stddev:32475.75 (277.0%) stddev-sans-first:32527.49 07:25:44 INFO - PROCESS | 7671 | Values: 761.6 804.3 835.9 843.5 847.4 14600.4 15513.1 15542.5 15569.6 15759.2 15453.8 15718.6 15746.3 15752.7 15759.8 793.4 800.3 812.7 814.4 815.2 824.4 835.0 845.2 845.3 846.3 871.6 871.6 872.8 878.6 879.2 864.2 870.7 872.1 872.7 872.7 635.9 636.3 636.3 636.4 636.6 15317.6 15524.7 15538.8 15541.5 15572.5 15503.9 15504.2 15547.8 15548.5 15698.3 13091.7 13155.3 13240.9 13307.5 13736.3 3941.1 3941.3 3966.5 3967.9 4092.2 87959.0 88080.6 88324.0 90082.0 90241.0 11348.2 11551.4 11759.5 12200.9 12239.9 19560.4 19781.4 19868.9 19871.2 19900.8 8536.4 8632.3 8745.3 8848.1 8884.4 4522.8 4598.1 4635.9 4702.0 4819.0 3547.7 3673.8 3675.9 3678.9 3696.5 656.8 658.3 659.6 678.4 680.3 750.9 763.7 775.3 788.4 793.0 9628.7 9871.0 10115.5 10133.3 10480.0 615.3 743.3 760.5 766.2 770.3 4764.7 5240.1 5545.8 5643.0 5655.2 77835.0 103624.0 128100.4 129850.0 130612.0 111522.0 114792.0 114814.0 114879.0 116432.0 95680.0 100046.0 101585.2 101658.0 102424.0 10387.6 10657.3 10657.9 10680.7 10689.5 48334.0 49087.5 55289.2 55976.0 56231.7 53167.7 57826.0 66225.0 78082.2 79108.2 12779.0 13123.5 13359.6 13368.0 13860.4 13255.0 14983.8 15307.4 15881.2 15912.1 14554.9 14638.3 14686.8 14825.9 15511.4 14000.4 14292.9 14329.3 14492.6 14506.7 13675.7 14042.6 14172.3 14638.6 14876.2 11349.7 11594.0 11753.6 11907.5 11916.7 11020.9 11718.1 11963.2 12100.3 12214.9 07:25:44 INFO - PROCESS | 7671 | -------- Summary: end -------- 07:25:44 INFO - PROCESS | 7671 | 07:25:45 INFO - TEST-INFO | 7671: exit 0 07:25:45 INFO - TEST-OK | dromaeo_css | took 1112106ms 07:25:45 INFO - TEST-START | kraken 07:25:45 INFO - operating with platform_type : linux_ 07:25:45 INFO - Initialising browser for kraken test... 07:25:45 INFO - TEST-INFO | started process 7922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXJkHi/profile http://localhost:39670/getInfo.html) 07:25:50 INFO - PROCESS | 7922 | __metrics Screen width/height:1600/1200 07:25:50 INFO - PROCESS | 7922 | colorDepth:24 07:25:50 INFO - PROCESS | 7922 | Browser inner width/height: 1024/697 07:25:50 INFO - PROCESS | 7922 | __metrics 07:25:50 ERROR - PROCESS | 7922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:25:51 INFO - TEST-INFO | 7922: exit 0 07:25:51 INFO - Browser initialized. 07:25:51 INFO - Running cycle 1/1 for kraken test... 07:25:51 INFO - TEST-INFO | started process 8041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXJkHi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:03 INFO - PROCESS | 8041 | RSS: Main: 168701952 07:26:03 INFO - PROCESS | 8041 | 07:26:06 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39670/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:06 INFO - PROCESS | 8041 | RSS: Main: 173961216 07:26:06 INFO - PROCESS | 8041 | 07:26:09 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39670/tests/kraken/driver.html?testName=audio-dft) 07:26:10 INFO - PROCESS | 8041 | RSS: Main: 173289472 07:26:10 INFO - PROCESS | 8041 | 07:26:13 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39670/tests/kraken/driver.html?testName=audio-fft) 07:26:13 INFO - PROCESS | 8041 | RSS: Main: 167968768 07:26:13 INFO - PROCESS | 8041 | 07:26:15 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39670/tests/kraken/driver.html?testName=audio-oscillator) 07:26:16 INFO - PROCESS | 8041 | RSS: Main: 168910848 07:26:16 INFO - PROCESS | 8041 | 07:26:18 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:19 INFO - PROCESS | 8041 | RSS: Main: 169357312 07:26:19 INFO - PROCESS | 8041 | 07:26:22 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39670/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:23 INFO - PROCESS | 8041 | RSS: Main: 170074112 07:26:23 INFO - PROCESS | 8041 | 07:26:26 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39670/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:27 INFO - PROCESS | 8041 | RSS: Main: 170291200 07:26:27 INFO - PROCESS | 8041 | 07:26:29 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39670/tests/kraken/driver.html?testName=json-parse-financial) 07:26:30 INFO - PROCESS | 8041 | RSS: Main: 169074688 07:26:30 INFO - PROCESS | 8041 | 07:26:32 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:32 INFO - PROCESS | 8041 | RSS: Main: 169119744 07:26:32 INFO - PROCESS | 8041 | 07:26:34 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:35 INFO - PROCESS | 8041 | RSS: Main: 169660416 07:26:35 INFO - PROCESS | 8041 | 07:26:37 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:37 INFO - PROCESS | 8041 | RSS: Main: 170012672 07:26:37 INFO - PROCESS | 8041 | 07:26:40 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:41 INFO - PROCESS | 8041 | RSS: Main: 170192896 07:26:41 INFO - PROCESS | 8041 | 07:26:43 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:44 INFO - PROCESS | 8041 | RSS: Main: 170373120 07:26:44 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | Cycle 1(1): loaded http://localhost:39670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39670/tests/kraken/driver.html?testName=ai-astar) 07:26:46 INFO - PROCESS | 8041 | RSS: Main: 171098112 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | __start_tp_report 07:26:46 INFO - PROCESS | 8041 | _x_x_mozilla_page_load 07:26:46 INFO - PROCESS | 8041 | _x_x_mozilla_page_load_details 07:26:46 INFO - PROCESS | 8041 | |i|pagename|runs| 07:26:46 INFO - PROCESS | 8041 | |0;ai-astar;102;110;106;112;111;112;112;113;110;111 07:26:46 INFO - PROCESS | 8041 | |1;audio-beat-detection;153;121;139;174;119;145;150;122;174;124 07:26:46 INFO - PROCESS | 8041 | |2;audio-dft;163;162;162;162;163;164;177;168;165;162 07:26:46 INFO - PROCESS | 8041 | |3;audio-fft;76;75;76;169;75;75;79;75;175;75 07:26:46 INFO - PROCESS | 8041 | |4;audio-oscillator;84;84;143;84;84;84;145;84;83;137 07:26:46 INFO - PROCESS | 8041 | |5;imaging-gaussian-blur;118;117;117;118;118;118;117;118;118;120 07:26:46 INFO - PROCESS | 8041 | |6;imaging-darkroom;147;147;148;148;149;148;147;147;147;150 07:26:46 INFO - PROCESS | 8041 | |7;imaging-desaturate;95;96;96;96;100;100;100;101;95;96 07:26:46 INFO - PROCESS | 8041 | |8;json-parse-financial;53;56;53;55;55;53;57;54;53;54 07:26:46 INFO - PROCESS | 8041 | |9;json-stringify-tinderbox;60;60;60;60;61;61;63;61;61;61 07:26:46 INFO - PROCESS | 8041 | |10;stanford-crypto-aes;77;75;76;75;75;75;84;84;80;75 07:26:46 INFO - PROCESS | 8041 | |11;stanford-crypto-ccm;131;117;137;135;120;122;120;140;160;131 07:26:46 INFO - PROCESS | 8041 | |12;stanford-crypto-pbkdf2;157;158;159;163;161;160;158;158;164;159 07:26:46 INFO - PROCESS | 8041 | |13;stanford-crypto-sha256-iterative;66;65;65;64;63;64;61;64;62;62 07:26:46 INFO - PROCESS | 8041 | __end_tp_report 07:26:46 INFO - PROCESS | 8041 | __start_cc_report 07:26:46 INFO - PROCESS | 8041 | _x_x_mozilla_cycle_collect,872 07:26:46 INFO - PROCESS | 8041 | __end_cc_report 07:26:46 INFO - PROCESS | 8041 | __startTimestamp1467383206338__endTimestamp 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | ------- Summary: start ------- 07:26:46 INFO - PROCESS | 8041 | Number of tests: 14 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.38 (3.0%) stddev-sans-first:2.05 07:26:46 INFO - PROCESS | 8041 | Values: 102.0 110.0 106.0 112.0 111.0 112.0 112.0 113.0 110.0 111.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:147.50 stddev:20.94 (14.2%) stddev-sans-first:21.83 07:26:46 INFO - PROCESS | 8041 | Values: 153.0 121.0 139.0 174.0 119.0 145.0 150.0 122.0 174.0 124.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.69 (2.9%) stddev-sans-first:4.92 07:26:46 INFO - PROCESS | 8041 | Values: 163.0 162.0 162.0 162.0 163.0 164.0 177.0 168.0 165.0 162.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:40.63 (54.2%) stddev-sans-first:42.50 07:26:46 INFO - PROCESS | 8041 | Values: 76.0 75.0 76.0 169.0 75.0 75.0 79.0 75.0 175.0 75.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:84.00 stddev:28.00 (33.3%) stddev-sans-first:28.99 07:26:46 INFO - PROCESS | 8041 | Values: 84.0 84.0 143.0 84.0 84.0 84.0 145.0 84.0 83.0 137.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 07:26:46 INFO - PROCESS | 8041 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 120.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 07:26:46 INFO - PROCESS | 8041 | Values: 147.0 147.0 148.0 148.0 149.0 148.0 147.0 147.0 147.0 150.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:95.50 stddev:2.42 (2.5%) stddev-sans-first:2.39 07:26:46 INFO - PROCESS | 8041 | Values: 95.0 96.0 96.0 96.0 100.0 100.0 100.0 101.0 95.0 96.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.42 (2.6%) stddev-sans-first:1.42 07:26:46 INFO - PROCESS | 8041 | Values: 53.0 56.0 53.0 55.0 55.0 53.0 57.0 54.0 53.0 54.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 07:26:46 INFO - PROCESS | 8041 | Values: 60.0 60.0 60.0 60.0 61.0 61.0 63.0 61.0 61.0 61.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:76.50 stddev:3.72 (4.9%) stddev-sans-first:3.94 07:26:46 INFO - PROCESS | 8041 | Values: 77.0 75.0 76.0 75.0 75.0 75.0 84.0 84.0 80.0 75.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:133.00 stddev:12.88 (9.7%) stddev-sans-first:13.66 07:26:46 INFO - PROCESS | 8041 | Values: 131.0 117.0 137.0 135.0 120.0 122.0 120.0 140.0 160.0 131.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.50 stddev:2.31 (1.4%) stddev-sans-first:2.24 07:26:46 INFO - PROCESS | 8041 | Values: 157.0 158.0 159.0 163.0 161.0 160.0 158.0 158.0 164.0 159.0 07:26:46 INFO - PROCESS | 8041 | 07:26:46 INFO - PROCESS | 8041 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.41 07:26:46 INFO - PROCESS | 8041 | Values: 66.0 65.0 65.0 64.0 63.0 64.0 61.0 64.0 62.0 62.0 07:26:46 INFO - PROCESS | 8041 | -------- Summary: end -------- 07:26:46 INFO - PROCESS | 8041 | 07:26:47 INFO - TEST-INFO | 8041: exit 0 07:26:47 INFO - TEST-OK | kraken | took 62061ms 07:26:47 INFO - SUITE-END | took 1174s 07:26:47 INFO - Completed test suite (00:19:34) 07:26:47 INFO - javascript benchmark 07:26:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7387.599069682405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.6056742907135, 3161.2887100402413, 3201.6638252983435, 3217.54954306397, 3231.176050107223, 5481.479259470349, 5495.697736624489, 5498.505134537891, 5600.5799565032585, 5606.971965140179, 5440.211169380437, 5475.479829416209, 5513.669179849212, 5514.36584792749, 5563.109902415615, 4980.178270585358, 5040.722760248185, 5079.79680812767, 5154.098032844256, 5179.715115668637, 784.4593347441441, 4851.927221091686, 4976.054549635558, 4983.875403114915, 4989.226669866159, 4998.700077995314, 5009.649324547247, 5038.974805125969, 5042.520960508764, 5048.394192696863, 5056.974715126437, 5058.570021548173, 5067.113255180328, 5085.644004919657, 5087.796488140507, 4938.407391113054, 4974.204127339608, 4991.101601711691, 5009.0, 5011.373578302712, 5486.204500347467, 5521.668699878021, 5527.695976721278, 5544.63959842613, 5597.552195824365, 5776.913346299809, 5884.0, 5897.587168898179, 5902.498287645555, 5930.733117009745, 6009.489193418564, 6042.697865106771, 6079.665618390986, 6090.5736598438125, 6110.7861224856915, 5662.745176467028, 5671.971640141773, 5674.971625141848, 5677.772889084432, 5687.459691329317, 5954.345022047572, 5957.970210148921, 5984.072468767348, 6155.907661385083, 6156.907646385308, 5826.126081087786, 5827.446392592697, 5827.79602713903, 5835.79574714883, 5844.386339434383, 5989.79035733756, 5992.730327135289, 5996.910046349309, 6006.819795406145, 6013.0, 5823.213866128103, 5846.561507886926, 5858.443447872445, 5915.704214789243, 5989.1914591529585, 5844.883102338014, 5849.824505264849, 5874.73563689635, 5889.263842019747, 5897.292324921037, 4393.736375817397, 4516.23224051912, 4517.141743068806, 4520.412346394947, 4569.086182763394, 3955.6835453163676, 3982.681385489212, 3990.4812374391145, 4027.3556231003486, 4033.858814941463, 5560.4161563036105, 5654.9151762723595, 5676.262085928803, 5729.341125770507, 5780.566457515619, 5888.587798854125, 6017.819465416044, 6035.155078289043, 6039.275286965592, 6046.425589569072, 5616.157576363578, 5645.576581756384, 5656.745446454919, 5718.085106382959, 5725.656460612377, 5103.87240318995, 5105.0, 5126.53861152498, 5144.717040562805, 5174.275601415805, 6009.879802403927, 6131.754729810757, 6168.136460895478, 6181.96909015461, 6185.659788711664, 5963.105534169736, 6045.78839740607, 6047.334793172836, 6047.969760151171, 6093.786717464867, 6189.35011823752, 6198.380161983766, 6205.100260462117, 6219.626822390671, 6247.5939063960695, 5744.856378590569, 5829.679367634821, 5839.824805255849, 5884.411558844081, 5893.734781934909, 5948.940510594839, 5956.106584012433, 5977.103434484862, 6003.549733769897, 6026.186464827192, 5769.79805706815, 5813.3605303417435, 5853.356130825691, 5878.088896221093, 5878.353381127987, 5640.492355688008, 5765.077587585966, 5771.7402716877, 5803.216565763737, 5809.593328466966, 5717.8570535736935, 5730.684812335361, 5746.9712651436475, 5755.366909639853, 5758.971205143947, 5846.210761547137, 5851.590388672922, 5860.531157507304, 5896.705164741831, 5906.586538942232, 5612.186232996274, 5681.8863622726485, 5696.515796157373, 5696.629719068247, 5797.681127538026], "value": 5447.246909300231, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2104606166521, 611.8317462697759, 616.2081724983394, 629.4303655192051, 654.7119267522293, 40187.79906100469, 41211.0, 45152.0, 45162.09675806486, 45183.77408112963, 45170.0, 45614.08771824562, 45704.54295457045, 45723.31415028769, 45811.08377832449, 8885.511296878669, 9030.00669926311, 9031.142041506046, 9039.457632542035, 9049.276057915384, 9030.954845225764, 9045.909540904573, 9063.41087829289, 9098.044705305947, 9100.226480749112, 9133.908660913405, 9179.0, 9187.127222913847, 9189.954050229739, 9209.539523023823, 9053.0, 9055.864162037575, 9118.088191180863, 9131.908680913173, 9133.954330228305, 8999.685011024583, 9020.77448063797, 9051.0, 9075.591598378089, 9078.182963533314, 32942.0, 43015.35476967848, 43041.35437968433, 43430.13139737188, 43460.56539434628, 3443.7933723976644, 3456.187795867969, 3558.928821423583, 3761.153740408386, 3776.244751049801, 31971.200719981953, 32012.199695007577, 32646.83676581602, 32804.179895502806, 33133.0, 4103.097318589906, 4127.442795222637, 4161.292580261363, 4205.3271476563605, 4341.45731783527, 312667.4366628175, 313004.0, 316516.0, 317250.0, 318653.0, 36775.632243677224, 37222.255554888754, 37271.0, 37392.0, 37488.25023499515, 39194.80402597969, 39627.0, 39750.20499589992, 39766.00584985399, 39800.0, 15363.615909602126, 15475.845241547666, 15492.690146197014, 15511.0, 15556.22218889051, 12422.316772577415, 12529.498820047096, 12542.749145017231, 12631.557895473798, 12680.429380677708, 9018.819623607491, 9047.823782908179, 9090.772730681785, 9102.635894564275, 9168.541572921327, 3468.2543253200683, 3494.895153145359, 3515.3320869035315, 3522.4716292556323, 3556.3065202285306, 944.7354740672623, 1087.2932593813925, 1116.0402054233352, 1130.8303754436736, 1175.5474142455216, 32942.34115317728, 33164.0, 33194.170145746066, 33423.498647520304, 33797.83101084479, 1096.4079397125622, 1127.425013243252, 1187.1155988788407, 1221.4137214137263, 1265.367316341829, 17455.38906138279, 17460.0, 17504.824951750576, 17601.11994400275, 17603.55991100233, 586330.0, 586720.0, 588582.0, 589816.5091745396, 591071.0, 58770.0, 58893.411065889646, 59221.40778592159, 59332.406675933555, 59409.702951484964, 1274.5857596281246, 1335.5525898823807, 1350.1021820489264, 1357.4027427931678, 1375.3810785146725, 30956.380872382877, 32324.353512929138, 32696.673033269362, 32841.50737738888, 32897.712868284834, 52135.739321303154, 52444.47555524549, 52858.735706321226, 52876.735616321675, 52919.735401322745, 461917.0, 464692.0, 465571.0, 465831.0, 466322.0, 29397.26506837346, 30019.0, 30165.09504714862, 30445.695543044287, 30474.390512190075, 49318.75340623274, 49639.503604964935, 50304.24543631775, 50330.748346258035, 50861.74569127279, 40542.39186412147, 42594.935126622084, 42749.870015598324, 42823.78588107164, 43045.3543196846, 42650.360244596974, 42652.57347426486, 42814.50149244761, 42842.57157428386, 42983.570164297955, 41296.0, 41687.374689379074, 41834.163316734106, 42502.78748606237, 42504.0, 35528.0, 37024.25951480901, 37613.623863762106, 37933.620663794114, 38406.23187536289, 28599.0, 28642.427151457272, 29063.709362906102, 29295.85352073226, 29333.559996600496], "value": 19177.166156212526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.64127567740405, 410.9486314210724, 412.5358971157448, 416.10744952077795, 425.2091110534407, 18546.53633659159, 19766.802331976676, 20265.797342026577, 20345.0, 20894.37316880496, 13076.73846523069, 13211.207327560352, 13367.264800435973, 13467.191968481873, 13544.864551354483, 5452.83641490755, 5582.720863956806, 5585.944140558603, 5604.85987850305, 5729.255196824407, 5725.856853578673, 5810.3027636683655, 5814.592978491507, 5853.473187413132, 5865.970670146643, 5796.594238403313, 5806.071028635419, 5835.4456326649115, 5845.503132233765, 5920.407959204067, 5765.5099316557935, 5890.587658863881, 5891.204687367193, 5923.496502797268, 5950.55370847186, 5192.688438693691, 5338.466153384669, 5342.038433082043, 5462.808801691922, 5499.642523235977, 14544.181977252843, 14999.775003374958, 15019.324130414157, 15040.473583424528, 15208.771868421982, 2223.7998580127864, 2227.231605096239, 2229.710137682107, 2234.084025549533, 2242.1367773407355, 11030.448477576088, 11410.486528106256, 13398.397072131778, 14528.346224419927, 14999.925000374928, 1817.71825367067, 1839.6320735852883, 1882.0777818868792, 1886.0663971334277, 1952.6778081616517, 89078.55460722654, 89459.55270223672, 90336.0, 90677.54661226651, 91802.54098729463, 10868.402237876993, 11318.660440186808, 12123.636290911287, 12208.206466579644, 12294.20087694297, 15988.520344389686, 15994.200289985454, 16001.599960001093, 16088.436904708278, 16170.353185872433, 8226.259636632733, 8425.325973922072, 8542.145785421533, 8597.226249637562, 8644.135586441305, 8076.515409075474, 8145.125529996059, 8266.380021498411, 8369.288610468178, 8440.704575339834, 4806.399200099988, 4957.677750946177, 4965.950340496621, 5038.496150385005, 5050.141475949097, 2082.427332483579, 2094.3402828109097, 2105.252645297901, 2113.38711773587, 2129.368623244468, 871.538084815049, 927.9953600231955, 1023.4933707814531, 1075.9193060520493, 1125.386664267976, 20564.177432902816, 20751.79248207529, 21039.263625773023, 21074.894625526773, 21114.261000864895, 1012.2104758288547, 1023.5496381592076, 1024.8155332040155, 1028.681108856242, 1043.88517263101, 11102.833457498144, 11629.47667354971, 11751.88248117525, 11818.290902545874, 11891.881081189078, 439884.0, 441345.0, 463940.5241633121, 465537.0, 466160.0, 92056.0, 95572.52213738886, 97154.51422742842, 98461.0, 98997.0, 991.8561808537721, 1029.7888932768765, 1032.5405194688292, 1041.245097304448, 1043.0612448796144, 17796.55508612295, 18084.45746627603, 18367.173477193825, 18400.447986559888, 18406.996829126478, 40939.59060409358, 42014.0, 42104.78947605242, 42829.287703939015, 44308.33537496876, 58765.0, 59246.70376648261, 62255.6887215561, 62863.05705414331, 63543.6822815883, 9070.546472676207, 9353.204977576983, 9419.576119074794, 9508.0, 9592.808143837225, 10349.151282368975, 13934.930325348309, 14449.422023118957, 14480.493182738554, 14508.274586270856, 12580.182288151242, 12596.937015314865, 12631.368431578201, 12663.0, 12829.679258018625, 12354.25874447536, 12363.567275145328, 12552.0, 12639.620811375673, 12820.0, 8913.55432228399, 9218.677346292847, 9423.905760942303, 9446.480443575669, 12915.289659068842, 13109.868901310865, 13358.933205333911, 13515.05394622367, 13574.86425135736, 13775.104618200186, 13094.476220951055, 13122.934385328012, 13215.339233038118, 13375.264360460269, 13662.863371366158], "value": 9452.696641795179, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.726435609412, 1497.6854860479298, 1658.86729061675, 1811.094452773614, 1832.9083545822705, 7756.767296981099, 8150.388720845931, 8312.168783121684, 8840.336974726897, 8856.202941735251, 8364.581770911445, 8383.161683831613, 8406.453580517262, 8427.452215605981, 8516.403851730382, 2352.6823878776404, 2390.760923907604, 2393.796527295182, 2403.3390817525146, 2421.8062554995645, 2406.9638955415594, 2412.2763171048705, 2435.476372579895, 2436.4396188876567, 2439.756024397555, 2366.8106551475926, 2391.5336509380677, 2392.892319845611, 2435.305937807725, 2441.963370549443, 2366.3729111785306, 2374.6912901322803, 2375.869327187004, 2379.9762002380016, 2398.1966041375986, 2357.610994185957, 2376.1683410806254, 2381.618940969454, 2381.8451800633075, 2409.084547871815, 8510.234078932865, 8510.87233691489, 8519.0, 8540.44487108336, 8579.742607721779, 5324.92012619811, 5441.455854414527, 5453.318335208099, 5465.726713664301, 5478.808241711521, 3291.1113999220074, 3331.600207975034, 3349.815760133192, 3369.073504786179, 3382.0530251529613, 1132.4281237974853, 1151.4588143572507, 1166.8658104318026, 1176.5117476247347, 1183.0240051957085, 11885.821712674317, 11975.520979160736, 11981.0, 12001.939990299992, 12024.51901923922, 4788.856334309976, 4791.496892826203, 4907.116718990616, 4973.303737476756, 4979.0, 10223.539940702687, 10224.28430009907, 10235.539400726986, 10269.383836969806, 10273.589056437659, 5409.756560954766, 5427.104527752956, 5444.809431669952, 5450.291462109901, 5454.072807622713, 4394.912101757947, 4854.271859221145, 4991.575716064175, 4996.150654388763, 5000.299958005882, 4077.7145599807727, 4144.290859680629, 4184.790760461965, 4234.555371685929, 4246.915061698749, 1338.5315139701222, 1357.4027427931678, 1357.8234829472106, 1364.3519328319167, 1380.1236215003344, 838.5974732128491, 923.9584218710174, 934.948577828226, 948.7059011706393, 967.583938906277, 5597.076482380443, 5950.9107363389585, 5976.491998180117, 5986.07215881539, 6188.81433556994, 933.6918816790443, 975.9365641233297, 982.2142286171035, 1002.9648962286285, 1059.5496913811598, 3754.155315054091, 3756.4928734620476, 3822.1591249924973, 3929.6814879220824, 3982.004498875281, 10638.202134839918, 10911.727206819734, 11025.173112016631, 11072.0, 11092.611758588571, 10828.566857325619, 10914.781704365869, 10923.0, 10966.287191332538, 10978.560857565768, 7817.257360550852, 8101.918980810116, 8216.917830821616, 8377.287930525852, 8379.036410812834, 5595.300587426572, 5764.827055188351, 5813.709314534341, 5913.645181289136, 6107.572469927062, 9036.186743193144, 9658.90341096608, 9682.806343873224, 9736.026397360207, 10146.492675366055, 10179.491025448846, 10205.540750666387, 10244.846327304947, 10249.641262555775, 10311.175105991353, 7399.186089530255, 8189.262966333059, 8197.959010204911, 8253.174682531699, 8371.748847534584, 8576.399652024547, 8586.184312490303, 8599.742007739778, 8618.181272779077, 8633.05036446003, 7626.466147369631, 7819.726309579138, 7819.726309579138, 7914.881276780968, 7920.84158316842, 7586.506877052974, 7678.846423071619, 7730.11103723079, 7755.030621172354, 7808.7657370278985, 7221.241769614325, 7223.927760722326, 7232.240614735588, 7232.493725439169, 7316.780496585111, 4786.904261914812, 4939.75301234944, 5035.521625445577, 5071.721055341844, 5081.923771143362, 5116.360454943132, 5144.922826157535, 5179.430262671179, 5199.168133098686, 5231.581473482036], "value": 4683.814496660319, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.37636319170286, 350.51278722575614, 352.95411596492465, 355.8878953129764, 355.9123466981713, 5734.569907256951, 5753.769849206037, 5771.913421298678, 5777.306723193217, 5801.274840644919, 5666.773329066843, 5669.319681638199, 5681.431856814316, 5691.516221121199, 5722.227499287595, 3806.471000701198, 4303.203907277164, 4379.737215767048, 4421.624161946223, 4455.198064348416, 4437.977810110961, 4452.577005184502, 4479.9552004479865, 4488.586095379961, 4490.9550904491025, 4437.156940181371, 4453.4433195850515, 4456.777161141946, 4464.0179160584785, 4465.6874018818535, 4284.785760711952, 4394.209042372372, 4404.427424434835, 4410.316400957857, 4475.5748203920575, 3938.251732170907, 3941.6452519273116, 3948.348522493785, 3956.9010774730573, 3965.325894597925, 5519.448055194489, 5558.166275058733, 5619.466150715716, 5631.943680563183, 5648.576356773258, 5094.541491265767, 5130.204818253177, 5146.893417915128, 5166.870828229286, 5184.6629969052265, 5937.910931336033, 5947.881042379171, 5963.850903727398, 5970.656432397871, 6030.66831324277, 4374.34384842273, 4395.318725597537, 4404.845830395952, 4406.713563618355, 4411.823527058914, 5999.950008748451, 6099.237595300588, 6171.228596425447, 6197.628142311431, 6207.4723648489935, 4367.323064924942, 4400.44994375703, 4401.537838526909, 4409.250427427345, 4414.690971631955, 4396.076823867023, 4413.205622987829, 4425.845095421645, 4454.198244316054, 4457.153140903218, 4931.975340123348, 5087.8982420351385, 5094.15946368845, 5096.490350964874, 5103.540681338697, 5956.344802071769, 5966.105084237312, 5998.340182579913, 6004.969975150097, 6043.184170137063, 1532.2491978930243, 1544.6678964022565, 1552.8447155284382, 1555.2690235589255, 1555.478914563634, 932.6502561539422, 981.3915372469115, 994.0556471352244, 998.6654470752234, 1002.5889385352117, 5239.502247286502, 5245.895082098336, 5284.867878302996, 5285.762140703678, 5288.439910226492, 5430.782768689287, 5432.619716619878, 5455.263539422127, 5455.954017243534, 5502.514321133272, 4852.976925786432, 5091.345312773289, 5119.436861945258, 5135.97432012845, 5137.6660517066275, 2859.313764696458, 2870.4546136234467, 2896.232498387929, 2908.9201221126573, 2919.32855443245, 5566.805161819317, 5572.58205634579, 5572.888542229132, 5594.272744543184, 5695.971520142372, 5362.731863406814, 5436.673799572039, 5570.100929349472, 5629.887402252014, 5633.6619802811965, 5640.0693885508435, 5657.0, 5676.858078548069, 5692.28846394209, 5717.4266083697685, 5144.228365745168, 5431.452036169672, 5452.973599652231, 5464.398916119303, 5494.857005767673, 5395.839894422718, 5407.648502847303, 5420.159875219348, 5427.457254274541, 5922.881542369215, 6349.127007532697, 6377.394147555975, 6414.0, 6434.485241180788, 6435.839104022437, 4414.933775993299, 4429.734215947054, 4430.291153415438, 4452.821887124479, 4454.910901782011, 6074.119252708244, 6111.602745821508, 6141.539384546266, 6154.907676384768, 6251.187345645037, 5966.3138739043825, 5981.850453738692, 5989.580729349078, 6000.4998750312425, 6004.189434426296, 5618.943810561842, 5974.253218347707, 6034.732706131762, 6065.696715164312, 6090.634561926298, 5863.853403664943, 5881.529477641864, 5925.192816191103, 5925.703714814328, 5936.465718085393, 6036.0, 6039.849003774765, 6074.96251874063, 6088.908666370096, 6116.633002019893, 5621.297337832771, 5852.7658893643775, 5911.408859114054, 5917.437843404869, 5920.348761636303], "value": 4441.9597485671065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.5735188294556, 804.3243675312737, 835.8871552340435, 843.4770442325758, 847.3898792869136, 14600.415983360666, 15513.069215847057, 15542.53372398827, 15569.610759730984, 15759.212039398013, 15453.845461545381, 15718.607034824106, 15746.291416886239, 15752.684946301068, 15759.842401575981, 793.4406243598249, 800.3357213512785, 812.7033632724043, 814.3892080939296, 815.1603848036502, 824.3734761581181, 835.0480452284401, 845.1590667286059, 845.3110714767475, 846.2933450568783, 871.5859966515918, 871.6208449324532, 872.7687162901836, 878.6046279174398, 879.1911441473827, 864.2308345572445, 870.6647940542905, 872.1060912564609, 872.7381785464336, 872.7381785464398, 635.8664680417118, 636.2619361540591, 636.2746469025315, 636.3954243468723, 636.6084857812458, 15317.617059573487, 15524.689506209812, 15538.844611553966, 15541.533753987398, 15572.454964076316, 15503.922480387526, 15504.224788760517, 15547.766783498144, 15548.455804046916, 15698.293576789072, 13091.738165236737, 13155.276459794708, 13240.86759132406, 13307.534236301779, 13736.313184340843, 3941.113249518864, 3941.2511622791862, 3966.5240171179353, 3967.8809635710977, 4092.1815636872743, 87959.0, 88080.55959720224, 88324.0, 90082.0, 90241.0, 11348.205625606128, 11551.36467494279, 11759.529618815322, 12200.938995304967, 12239.877601223874, 19560.413187604394, 19781.40655780329, 19868.90065549692, 19871.205151794056, 19900.800991989894, 8536.402451828313, 8632.309415246891, 8745.256653184424, 8848.070952550019, 8884.422512536794, 4522.760646108638, 4598.1033698429155, 4635.907281854344, 4701.976490117528, 4819.012102518976, 3547.733919956014, 3673.797941113211, 3675.9081022974638, 3678.889633311005, 3696.500972368696, 656.8226578823691, 658.2890478283442, 659.6306068601599, 678.4097834883585, 680.2857000149822, 750.9098908131059, 763.6868883757633, 775.3409601838392, 788.3929374381809, 793.0, 9628.71113866571, 9870.950645246729, 10115.544800483996, 10133.290669653054, 10480.0, 615.3446579392933, 743.31614914279, 760.4713731174331, 766.2300782670717, 770.3221165374434, 4764.690295130806, 5240.082985477527, 5545.7781688732, 5643.0, 5655.208270842086, 77835.0, 103623.96376036294, 128100.35949820191, 129850.0, 130612.0, 111522.0, 114792.0, 114814.0, 114879.0, 116432.0, 95680.0, 100046.0, 101585.1750391168, 101658.0, 102424.0, 10387.584496620051, 10657.25399222047, 10657.893421066, 10680.679579612624, 10689.51897164614, 48334.0, 49087.50912490829, 55289.1706624409, 55976.0, 56231.718841407164, 53167.734161328946, 57826.0, 66225.0, 78082.21917780749, 79108.20891791009, 12779.0, 13123.475060997453, 13359.599212023655, 13368.0, 13860.445582177003, 13255.0, 14983.775243371576, 15307.387704491695, 15881.205939703199, 15912.124833134289, 14554.854451455774, 14638.341274642453, 14686.840113152037, 14825.92587037058, 15511.37954481808, 14000.369983350978, 14292.85707142957, 14329.283535823375, 14492.637684057983, 14506.709865802835, 13675.658108547366, 14042.578722638336, 14172.291385430894, 14638.634034149232, 14876.181810000553, 11349.659510214708, 11594.044447978426, 11753.588624398106, 11907.464164112462, 11916.702082448008, 11020.901882114998, 11718.125898705835, 11963.234596624181, 12100.334481603597, 12214.877851221729], "value": 7912.020804231954, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 106.0, 112.0, 111.0, 112.0, 112.0, 113.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 139.0, 174.0, 119.0, 145.0, 150.0, 122.0, 174.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 164.0, 177.0, 168.0, 165.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 169.0, 75.0, 75.0, 79.0, 75.0, 175.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 84.0, 84.0, 84.0, 145.0, 84.0, 83.0, 137.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 120.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0, 147.0, 147.0, 150.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 100.0, 100.0, 100.0, 101.0, 95.0, 96.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 55.0, 55.0, 53.0, 57.0, 54.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 63.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 75.0, 75.0, 75.0, 84.0, 84.0, 80.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 117.0, 137.0, 135.0, 120.0, 122.0, 120.0, 140.0, 160.0, 131.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 159.0, 163.0, 161.0, 160.0, 158.0, 158.0, 164.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 63.0, 64.0, 61.0, 64.0, 62.0, 62.0], "value": 63.6, "unit": "score"}]}]} 07:26:47 INFO - Return code: 0 07:26:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:47 ERROR - # TBPL SUCCESS # 07:26:47 INFO - Running post-action listener: _resource_record_post_action 07:26:47 INFO - ##### 07:26:47 INFO - ##### Finished run-tests step (success) 07:26:47 INFO - ##### 07:26:47 INFO - Running post-run listener: _resource_record_post_run 07:26:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 568102912; Read time: 140; Write time: 379512 07:26:47 INFO - TinderboxPrint: CPU usage
13.4% 07:26:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 140 07:26:47 INFO - TinderboxPrint: I/O write bytes / time
568,102,912 / 379,512 07:26:47 INFO - TinderboxPrint: CPU idle
8,238.8 (86.6%) 07:26:47 INFO - TinderboxPrint: CPU user
1,217.2 (12.8%) 07:26:47 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273608704; Read time: 0; Write time: 216660 07:26:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294494208; Read time: 124; Write time: 162852 07:26:48 INFO - Running post-run listener: _upload_blobber_files 07:26:48 INFO - Blob upload gear active. 07:26:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:26:48 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'] 07:26:48 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 07:26:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:49 INFO - (blobuploader) - INFO - Done attempting. 07:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:52 INFO - (blobuploader) - INFO - Done attempting. 07:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:53 INFO - (blobuploader) - INFO - Done attempting. 07:26:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:53 INFO - Return code: 0 07:26:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c544601d67e893ff7eb207ba246021186cc4f968bea5a73b037cea33f748b946b2e29e2cf271793dd0927c92728c293a1b0e934a6dad297094ffd2edc10de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ff32adaa4de914bc52ad4cf8a3cf9489aef6a430c4f273819407b0c5152eb51ab9de245e6e54071351081bda41426d1737f37c4115e0c9ee0a99b7afec9447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c614d4edc050f5b80da85ded48f3da85420754009223838162b10d8aa54987db0a2125cbdef88855ed193ef83770d5f485625628ee5839e5b2361b3f81a31950"} 07:26:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:53 INFO - Contents: 07:26:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c544601d67e893ff7eb207ba246021186cc4f968bea5a73b037cea33f748b946b2e29e2cf271793dd0927c92728c293a1b0e934a6dad297094ffd2edc10de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ff32adaa4de914bc52ad4cf8a3cf9489aef6a430c4f273819407b0c5152eb51ab9de245e6e54071351081bda41426d1737f37c4115e0c9ee0a99b7afec9447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c614d4edc050f5b80da85ded48f3da85420754009223838162b10d8aa54987db0a2125cbdef88855ed193ef83770d5f485625628ee5839e5b2361b3f81a31950"} 07:26:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:53 INFO - Copying logs to upload dir... 07:26:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.816348 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-01 07:26:53.320607) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 07:26:53.323704) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c544601d67e893ff7eb207ba246021186cc4f968bea5a73b037cea33f748b946b2e29e2cf271793dd0927c92728c293a1b0e934a6dad297094ffd2edc10de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ff32adaa4de914bc52ad4cf8a3cf9489aef6a430c4f273819407b0c5152eb51ab9de245e6e54071351081bda41426d1737f37c4115e0c9ee0a99b7afec9447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c614d4edc050f5b80da85ded48f3da85420754009223838162b10d8aa54987db0a2125cbdef88855ed193ef83770d5f485625628ee5839e5b2361b3f81a31950"} build_url:https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/fpnkTB6YT1qeyQkvzF2nbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c544601d67e893ff7eb207ba246021186cc4f968bea5a73b037cea33f748b946b2e29e2cf271793dd0927c92728c293a1b0e934a6dad297094ffd2edc10de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ff32adaa4de914bc52ad4cf8a3cf9489aef6a430c4f273819407b0c5152eb51ab9de245e6e54071351081bda41426d1737f37c4115e0c9ee0a99b7afec9447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c614d4edc050f5b80da85ded48f3da85420754009223838162b10d8aa54987db0a2125cbdef88855ed193ef83770d5f485625628ee5839e5b2361b3f81a31950"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 07:26:53.349147) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:26:53.349488) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467380114.799155-1174806542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:26:53.432977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 07:26:53.433299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 07:26:53.433585) ========= ========= Total master_lag: 0.16 =========