builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1468747318.15 results: success (0) buildid: 20160717010853 builduid: 9e863a19fac64e50a016e772a3f82a7f revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.153573) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.154015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.154313) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.213294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.213624) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 02:21:58-- 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% 228M=0s 2016-07-17 02:21:58 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162464 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.415346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.415654) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.102708 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.533535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:58.533866) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 711963e8daa312ae06409f8ab5c06612cb0b8f7b --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 711963e8daa312ae06409f8ab5c06612cb0b8f7b --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=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 02:21:58,592 truncating revision to first 12 chars 2016-07-17 02:21:58,592 Setting DEBUG logging. 2016-07-17 02:21:58,592 attempt 1/10 2016-07-17 02:21:58,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/711963e8daa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 02:21:58,893 unpacking tar archive at: mozilla-central-711963e8daa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:59.205696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:59.206002) ========= script_repo_revision: 711963e8daa312ae06409f8ab5c06612cb0b8f7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:59.206426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:59.206812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:21:59.219439) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-17 02:21:59.219741) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:21:59 INFO - MultiFileLogger online at 20160717 02:21:59 in /builds/slave/test 02:21:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:21:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:21:59 INFO - {'append_to_log': False, 02:21:59 INFO - 'base_work_dir': '/builds/slave/test', 02:21:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:21:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:21:59 INFO - 'branch': 'Firefox-Non-PGO', 02:21:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:21:59 INFO - 'config_files': ('talos/linux_config.py',), 02:21:59 INFO - 'default_actions': ('clobber', 02:21:59 INFO - 'read-buildbot-config', 02:21:59 INFO - 'download-and-extract', 02:21:59 INFO - 'populate-webroot', 02:21:59 INFO - 'create-virtualenv', 02:21:59 INFO - 'install', 02:21:59 INFO - 'run-tests'), 02:21:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:21:59 INFO - 'download_minidump_stackwalk': True, 02:21:59 INFO - 'download_symbols': 'ondemand', 02:21:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:21:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:21:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:21:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:21:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:21:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:21:59 INFO - 'installer_path': 'installer.exe', 02:21:59 INFO - 'log_level': 'info', 02:21:59 INFO - 'log_name': 'talos', 02:21:59 INFO - 'log_to_console': True, 02:21:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:21:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:21:59 INFO - 'opt_config_files': (), 02:21:59 INFO - 'pip_index': False, 02:21:59 INFO - 'sps_profile': False, 02:21:59 INFO - 'sps_profile_interval': 0, 02:21:59 INFO - 'suite': 'dromaeojs-e10s', 02:21:59 INFO - 'system_bits': '32', 02:21:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:21:59 INFO - 'title': 'talos-linux64-ix-046', 02:21:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:21:59 INFO - 'use_talos_json': True, 02:21:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:21:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:21:59 INFO - 'work_dir': 'build'} 02:21:59 INFO - ##### 02:21:59 INFO - ##### Running clobber step. 02:21:59 INFO - ##### 02:21:59 INFO - Running pre-action listener: _resource_record_pre_action 02:21:59 INFO - Running main action method: clobber 02:21:59 INFO - rmtree: /builds/slave/test/build 02:21:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:00 INFO - Running post-action listener: _resource_record_post_action 02:22:00 INFO - ##### 02:22:00 INFO - ##### Finished clobber step (success) 02:22:00 INFO - ##### 02:22:00 INFO - ##### 02:22:00 INFO - ##### Running read-buildbot-config step. 02:22:00 INFO - ##### 02:22:00 INFO - Running pre-action listener: _resource_record_pre_action 02:22:00 INFO - Running main action method: read_buildbot_config 02:22:00 INFO - Using buildbot properties: 02:22:00 INFO - { 02:22:00 INFO - "project": "", 02:22:00 INFO - "product": "firefox", 02:22:00 INFO - "script_repo_revision": "production", 02:22:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:22:00 INFO - "repository": "", 02:22:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:22:00 INFO - "buildid": "20160717010853", 02:22:00 INFO - "pgo_build": "False", 02:22:00 INFO - "basedir": "/builds/slave/test", 02:22:00 INFO - "buildnumber": 399, 02:22:00 INFO - "slavename": "talos-linux64-ix-046", 02:22:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:22:00 INFO - "platform": "ubuntu64_hw", 02:22:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:22:00 INFO - "branch": "mozilla-central", 02:22:00 INFO - "repo_path": "mozilla-central", 02:22:00 INFO - "revision": "711963e8daa312ae06409f8ab5c06612cb0b8f7b", 02:22:00 INFO - "stage_platform": "linux64", 02:22:00 INFO - "builduid": "9e863a19fac64e50a016e772a3f82a7f", 02:22:00 INFO - "slavebuilddir": "test" 02:22:00 INFO - } 02:22:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:22:00 INFO - Running post-action listener: _resource_record_post_action 02:22:00 INFO - ##### 02:22:00 INFO - ##### Finished read-buildbot-config step (success) 02:22:00 INFO - ##### 02:22:00 INFO - ##### 02:22:00 INFO - ##### Running download-and-extract step. 02:22:00 INFO - ##### 02:22:00 INFO - Running pre-action listener: _resource_record_pre_action 02:22:00 INFO - Running main action method: download_and_extract 02:22:00 INFO - mkdir: /builds/slave/test/build/tests 02:22:00 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')]} 02:22:00 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:10 INFO - Downloaded 1361 bytes. 02:22:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:22:10 INFO - Using the following test package requirements: 02:22:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'jsshell-linux-x86_64.zip'], 02:22:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:10 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')]} 02:22:10 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:17 INFO - Downloaded 22763773 bytes. 02:22:17 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'] 02:22:17 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 02:22:18 INFO - Return code: 0 02:22:18 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 02:22:18 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')]} 02:22:18 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:19 INFO - Downloaded 22763773 bytes. 02:22:19 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'] 02:22:19 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 02:22:21 INFO - Return code: 0 02:22: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')]} 02:22:21 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:22 INFO - Downloaded 14403317 bytes. 02:22:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:22:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:22:22 INFO - Return code: 0 02:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:22 INFO - https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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 02:22:23 INFO - Downloaded 57075538 bytes. 02:22:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:23 INFO - mkdir: /builds/slave/test/properties 02:22:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:23 INFO - Contents: 02:22:23 INFO - build_url:https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:22:24 INFO - Running post-action listener: _resource_record_post_action 02:22:24 INFO - Running post-action listener: set_extra_try_arguments 02:22:24 INFO - ##### 02:22:24 INFO - ##### Finished download-and-extract step (success) 02:22:24 INFO - ##### 02:22:24 INFO - ##### 02:22:24 INFO - ##### Running populate-webroot step. 02:22:24 INFO - ##### 02:22:24 INFO - Running pre-action listener: _resource_record_pre_action 02:22:24 INFO - Running main action method: populate_webroot 02:22:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:24 INFO - '--tppagecycles', 02:22:24 INFO - '7'], 02:22:24 INFO - 'tests': ['tsvgm']}}, 02:22:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['damp', 'tps']}, 02:22:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'tests': ['damp', 'tps']}, 02:22:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['dromaeo_dom']}, 02:22:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['basic_compositor_video']}, 02:22:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:22:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['a11yr', 02:22:24 INFO - 'ts_paint', 02:22:24 INFO - 'tpaint', 02:22:24 INFO - 'sessionrestore', 02:22:24 INFO - 'sessionrestore_no_auto_restore', 02:22:24 INFO - 'tabpaint']}, 02:22:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['tsvgx', 02:22:24 INFO - 'tsvgr_opacity', 02:22:24 INFO - 'tart', 02:22:24 INFO - 'tscrollx', 02:22:24 INFO - 'cart']}, 02:22:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:24 INFO - 'tsvgr_opacity', 02:22:24 INFO - 'tart', 02:22:24 INFO - 'tscrollx', 02:22:24 INFO - 'cart']}, 02:22:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'talos_options': ['--disable-e10s'], 02:22:24 INFO - 'tests': ['tp5o']}, 02:22:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'tests': ['tp5o']}, 02:22:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'talos_options': ['--disable-e10s', 02:22:24 INFO - '--xperf_path', 02:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:24 INFO - 'tests': ['tp5n']}, 02:22:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:24 INFO - 'talos_options': ['--xperf_path', 02:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:24 INFO - 'tests': ['tp5n']}}, 02:22:24 INFO - 'talos.zip': {'path': '', 02:22:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:24 INFO - Running post-action listener: _resource_record_post_action 02:22:24 INFO - ##### 02:22:24 INFO - ##### Finished populate-webroot step (success) 02:22:24 INFO - ##### 02:22:24 INFO - ##### 02:22:24 INFO - ##### Running create-virtualenv step. 02:22:24 INFO - ##### 02:22:24 INFO - Running pre-action listener: _resource_record_pre_action 02:22:24 INFO - Running main action method: create_virtualenv 02:22:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:22:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:24 INFO - Using real prefix '/usr' 02:22:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:27 INFO - Installing pip.................done. 02:22:27 INFO - Return code: 0 02:22:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:22:27 INFO - Using env: {'DISPLAY': ':0', 02:22:27 INFO - 'HOME': '/home/cltbld', 02:22:27 INFO - 'LANG': 'en_US.UTF-8', 02:22:27 INFO - 'LANGUAGE': 'en_US:en', 02:22:27 INFO - 'LOGNAME': 'cltbld', 02:22:27 INFO - 'MAIL': '/var/mail/cltbld', 02:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:27 INFO - 'MOZ_NO_REMOTE': '1', 02:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:27 INFO - 'NO_EM_RESTART': '1', 02:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:27 INFO - 'PWD': '/builds/slave/test', 02:22:27 INFO - 'SHELL': '/bin/bash', 02:22:27 INFO - 'SHLVL': '1', 02:22:27 INFO - 'TERM': 'linux', 02:22:27 INFO - 'TMOUT': '86400', 02:22:27 INFO - 'USER': 'cltbld', 02:22:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:27 INFO - '_': '/tools/buildbot/bin/python'} 02:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:28 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 02:22:28 INFO - Cleaning up... 02:22:28 INFO - Return code: 0 02:22:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:28 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')]} 02:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:28 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')]} 02:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:28 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:28 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 02:22:28 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 02:22:28 INFO - Using env: {'DISPLAY': ':0', 02:22:28 INFO - 'HOME': '/home/cltbld', 02:22:28 INFO - 'LANG': 'en_US.UTF-8', 02:22:28 INFO - 'LANGUAGE': 'en_US:en', 02:22:28 INFO - 'LOGNAME': 'cltbld', 02:22:28 INFO - 'MAIL': '/var/mail/cltbld', 02:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:28 INFO - 'MOZ_NO_REMOTE': '1', 02:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:28 INFO - 'NO_EM_RESTART': '1', 02:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:28 INFO - 'PWD': '/builds/slave/test', 02:22:28 INFO - 'SHELL': '/bin/bash', 02:22:28 INFO - 'SHLVL': '1', 02:22:28 INFO - 'TERM': 'linux', 02:22:28 INFO - 'TMOUT': '86400', 02:22:28 INFO - 'USER': 'cltbld', 02:22:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:28 INFO - '_': '/tools/buildbot/bin/python'} 02:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:28 INFO - Downloading/unpacking psutil>=3.1.1 02:22:28 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 02:22:28 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 02:22:28 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 02:22:28 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 02:22:28 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 02:22:28 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 02:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:30 INFO - Installing collected packages: psutil 02:22:30 INFO - Running setup.py install for psutil 02:22:30 INFO - building 'psutil._psutil_linux' extension 02:22:30 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 02:22:32 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 02:22:32 INFO - building 'psutil._psutil_posix' extension 02:22:32 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 02:22:32 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 02:22:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:32 INFO - Successfully installed psutil 02:22:32 INFO - Cleaning up... 02:22:32 INFO - Return code: 0 02:22:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:32 INFO - Using env: {'DISPLAY': ':0', 02:22:32 INFO - 'HOME': '/home/cltbld', 02:22:32 INFO - 'LANG': 'en_US.UTF-8', 02:22:32 INFO - 'LANGUAGE': 'en_US:en', 02:22:32 INFO - 'LOGNAME': 'cltbld', 02:22:32 INFO - 'MAIL': '/var/mail/cltbld', 02:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:32 INFO - 'MOZ_NO_REMOTE': '1', 02:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:32 INFO - 'NO_EM_RESTART': '1', 02:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:32 INFO - 'PWD': '/builds/slave/test', 02:22:32 INFO - 'SHELL': '/bin/bash', 02:22:32 INFO - 'SHLVL': '1', 02:22:32 INFO - 'TERM': 'linux', 02:22:32 INFO - 'TMOUT': '86400', 02:22:32 INFO - 'USER': 'cltbld', 02:22:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:32 INFO - '_': '/tools/buildbot/bin/python'} 02:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:33 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 02:22:33 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 02:22:33 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 02:22:33 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 02:22:33 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 02:22:33 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 02:22:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:35 INFO - Installing collected packages: mozsystemmonitor 02:22:35 INFO - Running setup.py install for mozsystemmonitor 02:22:35 INFO - Successfully installed mozsystemmonitor 02:22:35 INFO - Cleaning up... 02:22:35 INFO - Return code: 0 02:22:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:22:35 INFO - Using env: {'DISPLAY': ':0', 02:22:35 INFO - 'HOME': '/home/cltbld', 02:22:35 INFO - 'LANG': 'en_US.UTF-8', 02:22:35 INFO - 'LANGUAGE': 'en_US:en', 02:22:35 INFO - 'LOGNAME': 'cltbld', 02:22:35 INFO - 'MAIL': '/var/mail/cltbld', 02:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:35 INFO - 'MOZ_NO_REMOTE': '1', 02:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:35 INFO - 'NO_EM_RESTART': '1', 02:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:35 INFO - 'PWD': '/builds/slave/test', 02:22:35 INFO - 'SHELL': '/bin/bash', 02:22:35 INFO - 'SHLVL': '1', 02:22:35 INFO - 'TERM': 'linux', 02:22:35 INFO - 'TMOUT': '86400', 02:22:35 INFO - 'USER': 'cltbld', 02:22:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:35 INFO - '_': '/tools/buildbot/bin/python'} 02:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:37 INFO - warning: no files found matching '*.txt' 02:22:37 INFO - no previously-included directories found matching 'build' 02:22:37 INFO - no previously-included directories found matching 'dist' 02:22:37 INFO - no previously-included directories found matching '.git*' 02:22:37 INFO - Installing collected packages: jsonschema, functools32 02:22:37 INFO - Running setup.py install for functools32 02:22:37 INFO - warning: no files found matching '*.txt' 02:22:37 INFO - no previously-included directories found matching 'build' 02:22:37 INFO - no previously-included directories found matching 'dist' 02:22:37 INFO - no previously-included directories found matching '.git*' 02:22:37 INFO - Successfully installed jsonschema functools32 02:22:37 INFO - Cleaning up... 02:22:37 INFO - Return code: 0 02:22:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:37 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')]} 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 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')]} 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:37 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:37 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 02:22:37 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 02:22:37 INFO - Using env: {'DISPLAY': ':0', 02:22:37 INFO - 'HOME': '/home/cltbld', 02:22:37 INFO - 'LANG': 'en_US.UTF-8', 02:22:37 INFO - 'LANGUAGE': 'en_US:en', 02:22:37 INFO - 'LOGNAME': 'cltbld', 02:22:37 INFO - 'MAIL': '/var/mail/cltbld', 02:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:37 INFO - 'MOZ_NO_REMOTE': '1', 02:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:37 INFO - 'NO_EM_RESTART': '1', 02:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:37 INFO - 'PWD': '/builds/slave/test', 02:22:37 INFO - 'SHELL': '/bin/bash', 02:22:37 INFO - 'SHLVL': '1', 02:22:37 INFO - 'TERM': 'linux', 02:22:37 INFO - 'TMOUT': '86400', 02:22:37 INFO - 'USER': 'cltbld', 02:22:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:37 INFO - '_': '/tools/buildbot/bin/python'} 02:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:40 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 02:22:40 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 02:22:40 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 02:22:40 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 02:22:40 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 02:22:40 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 02:22:40 INFO - Downloading docopt-0.6.1.tar.gz 02:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:40 INFO - Running setup.py install for blobuploader 02:22:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:40 INFO - Running setup.py install for requests 02:22:41 INFO - Running setup.py install for docopt 02:22:41 INFO - Successfully installed blobuploader requests docopt 02:22:41 INFO - Cleaning up... 02:22:41 INFO - Return code: 0 02:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:41 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:41 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 02:22:41 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 02:22:41 INFO - Using env: {'DISPLAY': ':0', 02:22:41 INFO - 'HOME': '/home/cltbld', 02:22:41 INFO - 'LANG': 'en_US.UTF-8', 02:22:41 INFO - 'LANGUAGE': 'en_US:en', 02:22:41 INFO - 'LOGNAME': 'cltbld', 02:22:41 INFO - 'MAIL': '/var/mail/cltbld', 02:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:41 INFO - 'MOZ_NO_REMOTE': '1', 02:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:41 INFO - 'NO_EM_RESTART': '1', 02:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:41 INFO - 'PWD': '/builds/slave/test', 02:22:41 INFO - 'SHELL': '/bin/bash', 02:22:41 INFO - 'SHLVL': '1', 02:22:41 INFO - 'TERM': 'linux', 02:22:41 INFO - 'TMOUT': '86400', 02:22:41 INFO - 'USER': 'cltbld', 02:22:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:41 INFO - '_': '/tools/buildbot/bin/python'} 02:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:41 INFO - Running setup.py (path:/tmp/pip-4p7P_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:41 INFO - Running setup.py (path:/tmp/pip-lRlWsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:41 INFO - Running setup.py (path:/tmp/pip-KWI0fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:41 INFO - Running setup.py (path:/tmp/pip-Y0BNGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:41 INFO - Running setup.py (path:/tmp/pip-F5O3Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:41 INFO - Running setup.py (path:/tmp/pip-0vVrpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:41 INFO - Running setup.py (path:/tmp/pip-tCyVhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:41 INFO - Running setup.py (path:/tmp/pip-rpyK9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:42 INFO - Running setup.py (path:/tmp/pip-Hg6GEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:42 INFO - Running setup.py (path:/tmp/pip-e7RW41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:42 INFO - Running setup.py (path:/tmp/pip-9rV8rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:42 INFO - Running setup.py (path:/tmp/pip-3Pkbsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:42 INFO - Running setup.py (path:/tmp/pip-Ps_cls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:42 INFO - Running setup.py (path:/tmp/pip-yb9CMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:42 INFO - Running setup.py (path:/tmp/pip-nbO2s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:42 INFO - Running setup.py (path:/tmp/pip-DEEAUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:42 INFO - Running setup.py (path:/tmp/pip-pYHfJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:42 INFO - Running setup.py install for manifestparser 02:22:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:42 INFO - Running setup.py install for mozcrash 02:22:42 INFO - Running setup.py install for mozdebug 02:22:42 INFO - Running setup.py install for mozdevice 02:22:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for mozfile 02:22:43 INFO - Running setup.py install for mozhttpd 02:22:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for mozinfo 02:22:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for mozInstall 02:22:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for mozleak 02:22:43 INFO - Running setup.py install for mozlog 02:22:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for moznetwork 02:22:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:43 INFO - Running setup.py install for mozprocess 02:22:43 INFO - Running setup.py install for mozprofile 02:22:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:44 INFO - Running setup.py install for mozrunner 02:22:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:44 INFO - Running setup.py install for mozscreenshot 02:22:44 INFO - Running setup.py install for moztest 02:22:44 INFO - Running setup.py install for mozversion 02:22:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:44 INFO - Cleaning up... 02:22:44 INFO - Return code: 0 02:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:44 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:44 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 02:22:44 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 02:22:44 INFO - Using env: {'DISPLAY': ':0', 02:22:44 INFO - 'HOME': '/home/cltbld', 02:22:44 INFO - 'LANG': 'en_US.UTF-8', 02:22:44 INFO - 'LANGUAGE': 'en_US:en', 02:22:44 INFO - 'LOGNAME': 'cltbld', 02:22:44 INFO - 'MAIL': '/var/mail/cltbld', 02:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:44 INFO - 'MOZ_NO_REMOTE': '1', 02:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:44 INFO - 'NO_EM_RESTART': '1', 02:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:44 INFO - 'PWD': '/builds/slave/test', 02:22:44 INFO - 'SHELL': '/bin/bash', 02:22:44 INFO - 'SHLVL': '1', 02:22:44 INFO - 'TERM': 'linux', 02:22:44 INFO - 'TMOUT': '86400', 02:22:44 INFO - 'USER': 'cltbld', 02:22:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:44 INFO - '_': '/tools/buildbot/bin/python'} 02:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:44 INFO - Running setup.py (path:/tmp/pip-My60DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:44 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)) 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:44 INFO - Running setup.py (path:/tmp/pip-10qzrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:44 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)) 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:44 INFO - Running setup.py (path:/tmp/pip-lgrK24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:44 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)) 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:44 INFO - Running setup.py (path:/tmp/pip-k1Ydlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:44 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)) 02:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:44 INFO - Running setup.py (path:/tmp/pip-sLh99q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:45 INFO - Running setup.py (path:/tmp/pip-vsve9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:45 INFO - Running setup.py (path:/tmp/pip-tZEbY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:45 INFO - Running setup.py (path:/tmp/pip-D6nQvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:45 INFO - Running setup.py (path:/tmp/pip-49BBsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:45 INFO - Running setup.py (path:/tmp/pip-CtqDud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:45 INFO - Running setup.py (path:/tmp/pip-o4hG7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:45 INFO - Running setup.py (path:/tmp/pip-uMMGAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:45 INFO - Running setup.py (path:/tmp/pip-EvLjZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:45 INFO - Running setup.py (path:/tmp/pip-yZcH3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:45 INFO - Running setup.py (path:/tmp/pip-sh1KFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:45 INFO - Running setup.py (path:/tmp/pip-0Ualy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:45 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)) 02:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:45 INFO - Running setup.py (path:/tmp/pip-HNRZKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:45 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)) 02:22:45 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)) 02:22:45 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)) 02:22:45 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)) 02:22:45 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)) 02:22:45 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)) 02:22:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:47 INFO - Downloading blessings-1.6.tar.gz 02:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:47 INFO - Installing collected packages: blessings 02:22:47 INFO - Running setup.py install for blessings 02:22:48 INFO - Successfully installed blessings 02:22:48 INFO - Cleaning up... 02:22:48 INFO - Return code: 0 02:22:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:48 INFO - Reading from file tmpfile_stdout 02:22:48 INFO - Current package versions: 02:22:48 INFO - argparse == 1.2.1 02:22:48 INFO - blessings == 1.6 02:22:48 INFO - blobuploader == 1.2.4 02:22:48 INFO - docopt == 0.6.1 02:22:48 INFO - functools32 == 3.2.3-2 02:22:48 INFO - jsonschema == 2.5.1 02:22:48 INFO - manifestparser == 1.1 02:22:48 INFO - mozInstall == 1.12 02:22:48 INFO - mozcrash == 0.17 02:22:48 INFO - mozdebug == 0.1 02:22:48 INFO - mozdevice == 0.48 02:22:48 INFO - mozfile == 1.2 02:22:48 INFO - mozhttpd == 0.7 02:22:48 INFO - mozinfo == 0.9 02:22:48 INFO - mozleak == 0.1 02:22:48 INFO - mozlog == 3.2 02:22:48 INFO - moznetwork == 0.27 02:22:48 INFO - mozprocess == 0.23 02:22:48 INFO - mozprofile == 0.28 02:22:48 INFO - mozrunner == 6.12 02:22:48 INFO - mozscreenshot == 0.1 02:22:48 INFO - mozsystemmonitor == 0.3 02:22:48 INFO - moztest == 0.7 02:22:48 INFO - mozversion == 1.4 02:22:48 INFO - psutil == 3.1.1 02:22:48 INFO - requests == 1.2.3 02:22:48 INFO - wsgiref == 0.1.2 02:22:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:48 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')]} 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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')]} 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:48 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 02:22:48 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 02:22:48 INFO - Using env: {'DISPLAY': ':0', 02:22:48 INFO - 'HOME': '/home/cltbld', 02:22:48 INFO - 'LANG': 'en_US.UTF-8', 02:22:48 INFO - 'LANGUAGE': 'en_US:en', 02:22:48 INFO - 'LOGNAME': 'cltbld', 02:22:48 INFO - 'MAIL': '/var/mail/cltbld', 02:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:48 INFO - 'MOZ_NO_REMOTE': '1', 02:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:48 INFO - 'NO_EM_RESTART': '1', 02:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:48 INFO - 'PWD': '/builds/slave/test', 02:22:48 INFO - 'SHELL': '/bin/bash', 02:22:48 INFO - 'SHLVL': '1', 02:22:48 INFO - 'TERM': 'linux', 02:22:48 INFO - 'TMOUT': '86400', 02:22:48 INFO - 'USER': 'cltbld', 02:22:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:48 INFO - '_': '/tools/buildbot/bin/python'} 02:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 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)) 02:22:48 INFO - Cleaning up... 02:22:48 INFO - Return code: 0 02:22:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:48 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')]} 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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')]} 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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 0x2a3f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, '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': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', '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 02:22:48 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 02:22:48 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 02:22:48 INFO - Using env: {'DISPLAY': ':0', 02:22:48 INFO - 'HOME': '/home/cltbld', 02:22:48 INFO - 'LANG': 'en_US.UTF-8', 02:22:48 INFO - 'LANGUAGE': 'en_US:en', 02:22:48 INFO - 'LOGNAME': 'cltbld', 02:22:48 INFO - 'MAIL': '/var/mail/cltbld', 02:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:48 INFO - 'MOZ_NO_REMOTE': '1', 02:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:48 INFO - 'NO_EM_RESTART': '1', 02:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:48 INFO - 'PWD': '/builds/slave/test', 02:22:48 INFO - 'SHELL': '/bin/bash', 02:22:48 INFO - 'SHLVL': '1', 02:22:48 INFO - 'TERM': 'linux', 02:22:48 INFO - 'TMOUT': '86400', 02:22:48 INFO - 'USER': 'cltbld', 02:22:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:48 INFO - '_': '/tools/buildbot/bin/python'} 02:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:48 INFO - Cleaning up... 02:22:48 INFO - Return code: 0 02:22:48 INFO - Running post-action listener: _resource_record_post_action 02:22:48 INFO - Running post-action listener: _start_resource_monitoring 02:22:48 INFO - Starting resource monitoring. 02:22:48 INFO - ##### 02:22:48 INFO - ##### Finished create-virtualenv step (success) 02:22:48 INFO - ##### 02:22:48 INFO - ##### 02:22:48 INFO - ##### Running install step. 02:22:48 INFO - ##### 02:22:48 INFO - Running pre-action listener: _resource_record_pre_action 02:22:48 INFO - Running main action method: install 02:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:48 INFO - Reading from file tmpfile_stdout 02:22:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:49 INFO - Reading from file tmpfile_stdout 02:22:49 INFO - Output received: 02:22:49 INFO - Usage: mozinstall [options] installer 02:22:49 INFO - Options: 02:22:49 INFO - -h, --help show this help message and exit 02:22:49 INFO - -d DEST, --destination=DEST 02:22:49 INFO - Directory to install application into. [default: 02:22:49 INFO - "/builds/slave/test"] 02:22:49 INFO - --app=APP Application being installed. [default: firefox] 02:22:49 INFO - mkdir: /builds/slave/test/build/application 02:22:49 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'] 02:22:49 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 02:23:05 INFO - Reading from file tmpfile_stdout 02:23:05 INFO - Output received: 02:23:05 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:05 INFO - Running post-action listener: _resource_record_post_action 02:23:05 INFO - ##### 02:23:05 INFO - ##### Finished install step (success) 02:23:05 INFO - ##### 02:23:05 INFO - ##### 02:23:05 INFO - ##### Running run-tests step. 02:23:05 INFO - ##### 02:23:05 INFO - Running pre-action listener: _resource_record_pre_action 02:23:05 INFO - Running main action method: run_tests 02:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:05 INFO - Python 2.7.3 02:23:05 INFO - Return code: 0 02:23:05 INFO - grabbing minidump binary from tooltool 02:23:05 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')]} 02:23:05 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 0x2cfd570>, '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 0x2cfe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:05 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 02:23:05 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 02:23:05 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 02:23:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:05 INFO - Return code: 0 02:23:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 02:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 02:23:05 INFO - Using env: {'DISPLAY': ':0', 02:23:05 INFO - 'HOME': '/home/cltbld', 02:23:05 INFO - 'LANG': 'en_US.UTF-8', 02:23:05 INFO - 'LANGUAGE': 'en_US:en', 02:23:05 INFO - 'LOGNAME': 'cltbld', 02:23:05 INFO - 'MAIL': '/var/mail/cltbld', 02:23:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:05 INFO - 'MOZ_NO_REMOTE': '1', 02:23:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:05 INFO - 'NO_EM_RESTART': '1', 02:23:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:05 INFO - 'PWD': '/builds/slave/test', 02:23:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:05 INFO - 'SHELL': '/bin/bash', 02:23:05 INFO - 'SHLVL': '1', 02:23:05 INFO - 'TERM': 'linux', 02:23:05 INFO - 'TMOUT': '86400', 02:23:05 INFO - 'USER': 'cltbld', 02:23:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171', 02:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:05 INFO - '_': '/tools/buildbot/bin/python'} 02:23:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 02:23:05 INFO - mozversion application_buildid: 20160717010853 02:23:05 INFO - mozversion application_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 02:23:05 INFO - mozversion application_display_name: Nightly 02:23:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:05 INFO - mozversion application_name: Firefox 02:23:05 INFO - mozversion application_remotingname: firefox 02:23:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:23:05 INFO - mozversion application_vendor: Mozilla 02:23:05 INFO - mozversion application_version: 50.0a1 02:23:05 INFO - mozversion platform_buildid: 20160717010853 02:23:05 INFO - mozversion platform_changeset: 711963e8daa312ae06409f8ab5c06612cb0b8f7b 02:23:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:23:05 INFO - mozversion platform_version: 50.0a1 02:23:05 INFO - using testdate: 1468747385 02:23:05 INFO - actual date: 1468747385 02:23:05 INFO - starting webserver on 'localhost:54248' 02:23:05 INFO - SUITE-START | Running 2 tests 02:23:05 INFO - TEST-START | dromaeo_css 02:23:05 INFO - operating with platform_type : linux_ 02:23:05 INFO - Initialising browser for dromaeo_css test... 02:23:05 INFO - TEST-INFO | started process 3406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGjd1f/profile http://localhost:54248/getInfo.html) 02:23:09 INFO - PROCESS | 3406 | JavaScript error: , line 0: uncaught exception: undefined 02:23:12 INFO - PROCESS | 3406 | __metrics Screen width/height:1600/1200 02:23:12 INFO - PROCESS | 3406 | colorDepth:24 02:23:12 INFO - PROCESS | 3406 | Browser inner width/height: 1024/697 02:23:12 INFO - PROCESS | 3406 | __metrics 02:23:13 ERROR - PROCESS | 3406 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:23:14 INFO - TEST-INFO | 3406: exit 0 02:23:14 INFO - Browser initialized. 02:23:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:14 INFO - TEST-INFO | started process 3532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGjd1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:26 INFO - PROCESS | 3532 | RSS: Main: 169795584 02:23:26 INFO - PROCESS | 3532 | 02:24:15 INFO - PROCESS | 3532 | 1468747455782 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] 02:26:29 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54248/tests/dromaeo/cssquery-ext.html) 02:26:30 INFO - PROCESS | 3532 | RSS: Main: 170532864 02:26:30 INFO - PROCESS | 3532 | 02:29:33 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-ext.html (next: http://localhost:54248/tests/dromaeo/cssquery-jquery.html) 02:29:33 INFO - PROCESS | 3532 | RSS: Main: 169422848 02:29:33 INFO - PROCESS | 3532 | 02:32:35 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54248/tests/dromaeo/cssquery-mootools.html) 02:32:36 INFO - PROCESS | 3532 | RSS: Main: 172404736 02:32:36 INFO - PROCESS | 3532 | 02:35:38 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54248/tests/dromaeo/cssquery-prototype.html) 02:35:38 INFO - PROCESS | 3532 | RSS: Main: 167448576 02:35:38 INFO - PROCESS | 3532 | 02:38:41 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54248/tests/dromaeo/cssquery-yui.html) 02:38:42 INFO - PROCESS | 3532 | RSS: Main: 170070016 02:38:42 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:54248/tests/dromaeo/cssquery-yui.html (next: http://localhost:54248/tests/dromaeo/cssquery-dojo.html) 02:41:45 INFO - PROCESS | 3532 | RSS: Main: 172281856 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | __start_tp_report 02:41:45 INFO - PROCESS | 3532 | _x_x_mozilla_page_load 02:41:45 INFO - PROCESS | 3532 | _x_x_mozilla_page_load_details 02:41:45 INFO - PROCESS | 3532 | |i|pagename|runs| 02:41:45 INFO - PROCESS | 3532 | |0;dojo.html;2627.947441051179;2662.58729896866;2692.151972128778;2701.0816322450373;2702.081292360597;4775.06886157199;4792.424909010919;4808.591269742072;4859.757012149396;4916.582090522301;4632.07358528294;4784.258439941815;4807.543283388081;4824.035192961413;4825.396825396825;4379.058502421979;4404.053128577355;4490.326451032339;4512.819487220524;4525.773711314438;4201.411802347674;4452.933206001912;4461.977690111545;4524.6380289576755;4530.32045193222;4326.762028088454;4338.002259480306;4397.5602439756085;4398.054418300049;4463.085067561142;4379.737215767064;4386.56134386562;4414.183376075404;4422.491413487458;4447.866564003085;4388.275934470808;4412.426384570017;4421.159979603865;4442.444694413199;4449.6662750293535;4712.528747125294;4776.522347765231;4781.928271075902;4797.880052998668;4803.591694705954;5126.077306084903;5138.203578445309;5144.408393034774;5152.484751524855;5207.4011488678525;5143.305653736773;5158.432572417031;5185.118529849935;5190.92213616796;5210.166373380279;4836.322914791932;4843.39457567804;4844.709317440965;4844.861457557542;4899.730514821684;5325.227841962971;5330.92003619946;5332;5336.4129945705945;5354;4981.12830254704;4985.177445721415;4987.152184128707;5022.949770502249;5084.542391184737;4985.52637499437;5066.9746651266505;5096.923546146811;5105.566026887682;5112.437631860493;5055.974720126376;5063.164577844688;5089.898202036013;5111.488851114933;5113.079645663816;4946.678465899705;5005.6996580205305;5057.468965758616;5090.821821236313;5133.768980395891;4392.1874453226255;4402.591170825369;4443.178012067778;4445.155420470101;4449.9555004450185;3764.5670747863796;3778;3788.6969042476535;3835.53973523179;3855.845766169322;4251.043515209115;4407.757573333433;4413.249747542925;4418.779061046999;4425.137098265872;5218.739063046833;5235.947640523546;5265.973670131625;5275.366955965309;5284.735763211824;4454.5990860822685;4455.9554404456185;4457.286834106528;4495.820167193276;4529.365888775574;4536.886577835515;4658.324542941255;4671.883202919887;4674.672772905864;4702.365180700562;4848.272759086024;4893.926591101065;4919.680220785637;4936;4984.900301993867;5159.974200128975;5189.471904861327;5193.662411943212;5217.426083130928;5247.55395791362;4775.474697783172;4841.636877234151;4880.46314905353;4906.386701662293;4907.852764417074;5061.4938506150565;5091.694498330112;5100;5102.770375333044;5133.178691409356;5065.113605119163;5078.390593128848;5118.206677964921;5165.819196328111;5170.767315470737;4905.9018819624125;4986.975065124651;4990.226514890198;4999.950000500094;5028.899422011613;5041.42023667283;5062.772175252197;5065.797368105234;5070.442251352422;5127.79488820443;4791.305260737243;4910.975445122752;4921.409430868319;4935.383077115361;4975.278584605285;5050.04049230645;5054.69671819692;5062.645614806928;5072.492750724898;5111.028904508132;4861.319415281934;4920.8769780755765;4922.138625740553;4940.851774446773;4941.555260026615 02:41:45 INFO - PROCESS | 3532 | |1;ext.html;559.6697948210555;564.559643478087;575.470567078288;587.7237698281806;604.6704546022418;34842.825785871064;38058.23883522335;38264.617353826456;38279.61720382799;38302.23395532091;38523.42214866779;39141;39187;39206;39373.40939885897;7552.69789208431;7669.539827610333;7690.3078722914925;7699.230076992284;7754.651040703154;7698.191689872567;7761.456698031112;7787.610619469032;7800;7803;7808.1801410851895;7814.218578142197;7846.72536461224;7855.371570274393;7867.449278550504;7736.64608693482;7766.456348055638;7778.105517865433;7780.8832867507035;7785.065792104927;7663;7758.534487930742;7759.806004849867;7765.650545725456;7786;35258.118547036276;36136.819315903515;36173.27653446943;36214.275714485826;36224.275514489826;2799.118277742525;2857.6427946506687;2904.2158617173454;2970.0495841330785;2995.3859458810894;29060.27349316284;29151.271218219503;29393.70606293931;29855.701442985508;29938.101856944108;3319.1204330852343;3396.28677977625;3407.148212946763;3442.225499262671;3472.9826350868084;252852;253580;254012;255006;255277;32984;34114;50884.74557627188;51459.48540514622;51522;33628.831855840566;33839.83080084584;33891.66108338885;33940;33978.32043359168;12309.076819238593;12348.629541113782;12364.62906112818;12381.319027453397;12387.504499820086;10725.83911241332;10797.352158870493;10801;10825.891741082645;10831.729206769736;7833.569153696488;7851.764447066597;7857.096433910059;7906.130325664172;7956.840863182704;3095.5141532064736;3117.3191055692087;3136.7333776628784;3166.6358368787883;3220.0822765511716;857.562643052048;875.4047247871381;896.1576118448637;920.9685152629098;997.3716558568055;27729;28080.29799255035;28394.85802570974;28633.71366286352;28728.281792955342;916.2715641065369;924.893637231727;969.6315400147898;1008.2186305613209;1029.1098200057047;14737.705245895022;14743.631409214855;14809;14877.404903803726;15023.624409389853;405084;405414;407460;408306;409232;47873.5212647876;48195.277070843964;48426.75786621115;48516.7574162134;48807.755961220675;1185.964421067352;1205.662414523917;1206.7586482703318;1220.6765207220094;1222.0712258683463;25744.356391089623;26869.731302686723;27497.31256718598;27674.723252767213;27694;42463;46855;46863.29705054495;46879.29681054719;46932.29601555911;376230;378715;381089;381270;382700;24861.87569062143;25784.871075644503;37768.62231377651;38273.4258986121;38370.80814595909;41026;41294.58705413028;41375.172496550505;41496.792516037225;41603.7919810399;35380.46929296114;35606;36025.63974360223;36050;36340.454893176095;36248.81875590711;36584;36786.448203276435;36797.08007299839;36813.81593092017;34288.48567271443;34482;35295.47056794099;35358.46962295619;35671.82164089163;31405.842970785;32142.67857321397;32604.347913041132;32629.34741305208;32635.836820815744;25069.247922562354;25075.87462062678;25173.24480265595;25441.330213570818;25806.61290080613 02:41:45 INFO - PROCESS | 3532 | |2;jquery.html;378.95452545694513;379.41380567023947;380.7144641518859;388.92610404023253;395.17605791923836;16102.919485402572;17304.56738581536;17598.296068157273;18277.1775270113;18285.634287314246;17137.057461839595;17281.04954227517;17372.13139343034;17463.650726985485;17523.474295771117;5040.445550989379;5224.4775522447835;5250.081235783722;5252.028374750665;5256.342957130359;3830.674392676612;5726.3700992890745;6030.909536356936;6042.184305118819;6153.969230153843;5091.567216786578;6081.270247570275;6086.330503644617;6098.817035488943;6118.663473508956;5244.475552444763;5327.200919862013;5346.010987967238;5356;5360.437154098822;5204.115300398941;5340.706261155635;5351.598630102719;5352.411234764173;5441.238226648273;11426.485808138654;11528.42357882111;11601.187916845824;11639.127065470124;11661.591844285409;1741.2860727101827;1819.0995457248746;1891.7446144770418;2006.9096890639955;2403.8437501562344;9095.59069841852;9099.135582119688;9106.499142547158;9455.858162127573;9698.642190093393;1726.240454200148;1731.7402389641654;1771.5393997560598;1795.542136755132;1850.82472629881;61523.692381538254;61936.69031654813;64183.591463354176;64347.3565264346;69197;10009.299349045643;10098.394096354095;10246.385216886862;10271.435071071162;10372.844407333896;14063.578092657237;14105.717885642229;14165.929170354082;14199.78700319496;14213.928930355489;6798.388145066968;7194.20863704992;7270.3456688897195;7365.7790266292095;7393;6876.209235937931;6903.482238832108;6940.305969403019;7047.330503602149;7079.539829911039;4394.582514661102;4402.625776808943;4416.050549131888;4444.577765112309;4538.364628951949;1694.2799310293321;1708.5643160993866;1832.3495159218553;1884.6136542008855;1930.4328819385898;816.5508970066439;818.29217726666;837.6314421654574;841.2849078283532;962.2446379591987;16610.501684949228;17119.400820971205;17139.400120995706;17249.482515524553;17407.216675249645;840.7141571865473;845.572985642259;878.9428687135315;919.70569417787;939.6100618243353;9347.485888276211;9593.42439453635;9726.221902247804;9787.90212097884;9889.357191782512;383900;384160.3959901025;385829;387714;401710;71491.64254178696;71576.64211678908;71978.64010680017;75008.62495687486;75503;904.3398319227001;906.4878343735768;908.8091500784909;921.1387352824996;923.1460898668705;15238.085714857145;15286.159261240738;15337.923310383376;15390.307436165176;15806.683866322379;36719.26561468809;37314.6268537322;37602;37954.0511487204;38293.42559861549;49218.507814921395;50862.23706644477;51391.22913156381;51610.74194629003;51715.22427163671;4336.807377971083;4481.686281960231;5888.705564721832;6311.201307627304;7050.823729406806;7923.564203968837;8042.919570804217;9256.305777066613;10639.89360106389;10739.731506712395;9283.907160928304;9499.43003419797;9549;9558.522073896416;9620.615175393186;9048.547572621212;9067.186562687357;9278.11857873501;9310.674126405544;9335.57989890443;5492.670439773627;5628.887422251614;9206.480930646369;9822.263330250116;10158.695239142837;7218.566885986857;7252.927470725225;7270.527415717961;7373;7464.477486575887;9728.075832795874;9731.756706082404;9761.518502532454;9762.804743905224;9969.451680157661 02:41:45 INFO - PROCESS | 3532 | |3;mootools.html;1371.609091408948;1413.145047246416;1501.2868887278544;1607.2526275281991;1719.853812425943;6850.314968503148;7475.73834915778;7541.208173141817;8010.279074883259;8040.035195776508;7682.231776822329;7855.4893931894385;7917.2082791720795;7921.524708517493;7922.683092676286;2163.448320678229;2186.967195492069;2197.373748481683;2203.526241858;2205.8345624078256;2123.766385697572;2145.0454547726267;2218.3123231798113;2219.1012639880873;2230.721159855018;2130;2136.839737019722;2150.763416024236;2151.494398816285;2170.6852506386563;2133.57328534293;2141.5395689926586;2141.625215587266;2142.9785702142935;2145.1633862793524;2051.7332746742827;2069.2033567076633;2069.2757534862826;2084.218418093215;2084.3642688979853;7908.762737117896;7984.041914970183;7990.240927111915;8004.359651227888;8020;4611.377464042345;4741.407324084489;4753.952460475385;4756.405449318835;4756.904861902777;2970.5544168374918;3003.519436890087;3005.0534081764176;3032.924176895573;3120.594322738052;899.1458114790975;954.5609019850876;963.4026903319916;967.6951760195516;990.8216521026212;10595.841062383994;10712;10749.731256718645;10827.891721082768;10854;4062.6343629073526;4155.168966206771;4277.144571085795;4278.187144442546;4284.635805956528;9174.816503669888;9202.63189472427;9258.861117083114;9269;9289.767755806024;4696.436427628706;4711.764411779397;4720.976395118071;4730.858074257778;4735.976320118446;3660.1581636223286;4100.487439070116;4229.703920725581;4307.483102027777;4309.1381723655395;3712.6472985066375;3721.14413684854;3731.533558305212;3803.7337386382687;3844.9038774030873;1187.4834447015576;1211.4432953654511;1226.8282440458343;1233.5620854596489;1244.9688757781128;843.6245870587529;856.7815207122144;858.8454078265972;891.3893982621795;896.5965315608003;5475.7262136893;5489.670619762827;5505.6696598204235;5521.834344969658;5898.911516327258;886.2776836877924;899.6401439424283;927.8097989912187;953.909378609031;1002.4562174251716;3617.3127105849803;3641.2717456508803;3735.6824669902817;3802.4676545283683;3812.7140464465274;9700.417974921527;9922.751931201778;10022.398656080659;10027.348222365523;10035.598576056876;9856.162226210852;9952.552135153936;9973.650922217688;9991.850122248172;10021.448820314807;7365.631718414058;7554.055743032121;7569.697212111454;7589.392848572101;7620.1998790127345;5140.352718350127;5215.113430716863;5228.843134705965;5380.273663055437;5448.618596698193;9210.493422861808;9309.674161404319;9343.626254949726;9347.158755712018;9373.953130234306;8753.693620723245;9107;9115;9342.486163261086;9426;6073.939260607337;6320.905186422299;6493.545451818327;6662.034005069335;6876.243613202644;7624.27569380908;7685.193054729397;7707.421943354158;7755.379569634529;7760.611969401621;6869.313068693091;6970.930290697028;7069.434445244471;7154.39187669054;7180.066591343092;6925.515213935178;6949.027136201037;6973.860522789617;6975.9302406975285;7037.120359955005;6299.433051025429;6302.054691796267;6310.05349197624;6310.6213627182515;6318.241810982711;4545.340925565841;4547.113312903952;4639.744814035261;4661.720296782204;4669.556392142741;4544.091181763727;4603.58567728906;4655.464621568563;4679.181143299841;4697.201475749062 02:41:45 INFO - PROCESS | 3532 | |4;prototype.html;290.5598019001212;304.0740943826049;306.15806532036896;307.0726406253116;313.08735037366085;4872.853814385565;4938.407391113072;5029.597632189425;5107.438181800004;5119.283300337951;5002.949970500294;5016.247562865572;5017.272495488152;5042.495750424956;5043.823466178685;3956.5647778744315;3966.107625784204;3969.7249768940596;3971.7815520146382;3985.8007099645047;3920.2747491714126;3969.6625786808154;3977.2244412339605;3981.5421226558883;3983.1436241208135;3935.9212815743667;3941.1623630985787;3951.111000025;3964.5242570891533;3970.285348637244;3935.822887970048;3937.4290727844586;3940.4483372327895;3951.6048395160396;3962.3660214365564;3494.9825250873837;3497.6327485613897;3505.509228707983;3506.50908872758;3514.332276867387;4881.585065269456;4966.355978667227;4966.87582810429;4982.302477653131;5029.245613158056;4529.365888775574;4540.477845047796;4543.613792827614;4566.49768525462;4578.427696537933;5280.864614107947;5314.335708036496;5337.67973921562;5344.305240318772;5372.382176049726;3697.0413730732184;3805.904852378713;3827.502424684801;3837.0982819037504;3847.7883716395586;5571.359293681238;5577.52591029763;5585.469380408855;5590.608657393984;5640.125780504029;3915.2952468555363;3925.2924977634248;3929.9607003929596;3948.9605103949166;3957.1689945111275;3698.6486283802997;4002;4007.639312461834;4008.679305655599;4009.6190861868076;4496.257283057333;4496.651004698578;4497.955020449819;4511.1654343946475;4531.864044078683;5297.17893726473;5341.946580534145;5381.973090134525;5388.8113916013535;5399.595030372738;1273.987260127387;1365.7609918264463;1376.0986553807272;1384.5084994826893;1389.208151353739;964.875919553712;968.7239136845965;981.7251169672503;984.9409035457752;995.9890710928269;4014.558398576154;4050.4531888194715;4093.3246014407887;4110.383442483591;4110.671146308288;4764.76176191196;4826.686265392808;4849.756463094792;4857.222844344888;4866.732329721828;4087.816048277835;4096.836126554905;4097.815598298083;4113.85601503946;4138.896527586834;2496.450780828215;2573.2794817451145;2584.5993870950033;2594.896204151813;2604.8176627636262;4510.526394728572;4573.588377046015;4592.563706447882;4596.448426188812;4624.699394539344;4889.853304400874;4894.730789806524;4894.902101957941;4902.240152776325;4921.384826896638;4387.639831652198;4452.621527170162;4535.909281814411;4541.545845415498;4563.691323790292;4782.282657601388;4824.445188803333;4834.791302174456;4855.271709243641;4872.610191184767;4687.125149940051;4725.503822098768;4762.927911497134;4770.165221086366;4784.306275590089;4306;4503.842365517191;4546.40896683429;4551.886202844956;4565.927007153383;3596.4425514045365;3630.8003059830908;3643.799591022413;3676.5220521332058;3686.834092465899;4877.756112194447;4908.656394052382;4921.966387058757;5235.319408476874;5381.973090134525;5307.814226502054;5331.1470164773455;5331.733413329395;5344.438833922382;5375.193720941734;5314.548263397654;5322.4677532248015;5328.067588172132;5329.694224914766;5352.598555108305;5084.8220312288895;5225.869353266199;5253.632245742914;5255.421903590678;5266.34170728659;5336.386315573759;5376;5381.165919282517;5383.515483606494;5392.703401312965;5233.790648374023;5246.921296180637;5281.366236051698;5281.920771188512;5304.787808487617 02:41:45 INFO - PROCESS | 3532 | |5;yui.html;591.4292707537227;642.1459458919637;646.7154452041102;648.2383199740304;674.2616834566148;12959.74080518389;13927.025108242415;13981;13981.720365592682;14012.929935350308;11707.414629268524;11725.120615953794;11988.700282492942;12092.395380230975;12129.150959432822;758.7685755844465;779.5790273252437;782.0927723840347;787.5747096567846;789.0964845252183;756.9924300756977;761.7981234972737;763.7479631721519;763.8701420758457;765.4985984180371;823.7775800533852;824.286991752136;827.1315119124895;828.9378296627747;829.7801082713056;811.8701007838747;812.6911773526023;813.8982627171604;814.3810703865105;819.4550623835142;595.3718826637895;598.3507893935085;601.3535449391921;603.1977469964936;605.0349692240869;11609.361485118316;11635.650930472098;11711.824322635168;11746.29522228669;11780.882191178065;10041.146502547292;10130.9493452533;10198.898011019943;10277.383356998604;10450.79098418035;8868.246199073086;9280;9512.571934262975;9531.618735250582;9636.084571965652;3081.9691803082133;3112.8754849805982;3124;3127.660527848727;3138.497840345534;40360.79819600913;55205.723971380285;55777;59992;60053.399466005656;9057.456552606733;9195.40229885049;9633.421994680342;9705.320627556004;10459.581616735397;17321.220545075503;17440.47678569645;17468.737968930476;17505.474835754947;17546.385876494518;5862.765489380462;5889.146073819272;5950.404959504015;5967.9257733608365;6010.54920880927;3453.223024819446;3468.791872487659;3501.9824900875333;3530;3652.981735091361;2854.1152242804797;2959.9704002960125;2965.635807528561;2966.391889662614;2973.7323640872423;519.1926554208243;523.743365750787;529.5736931769962;530.729328042701;534.4628648208526;479.1925605354988;525.5007742644503;532.5446743034727;544.8991936491761;549.3823174396642;6948.33990770876;7025.5784652919965;7036.401905838061;7047.753328633473;7384.26157384268;449.341714388416;548.6516062300389;550.9696966666871;561.3852831149884;569.407815871489;3101.3177101037736;3151.306712523241;3196.9360612787614;3215.324781795802;3317.4857897026;54699.72650136804;55495.44504554984;76182;80260;80922.19077809264;49414.50585494171;60498;70738;71642;80034.5998270005;67414;73280.63359683167;75300.24699752932;76846;76901.61549192219;7699.384049275933;7987.600619968862;8040.195980401913;8110.905027821169;8260.173982601691;32232.677673222966;38741.6125838738;41660.1667966645;43296.56703432925;43984.34023489586;36428.63571364252;37039.81480092582;37155.814220928725;37358.6264137366;40534.1893162141;10576.524056417633;10587.364758114538;10631.096356809758;10669.199810014436;10847.891521085005;11153.72115697114;11339.433028348714;11547.422628868691;11656;12014;10457.68626941193;10457.895421045996;10790.73023174427;10838.891611083789;11244.887551124384;10274.12669923035;10298.330608510423;10673.89326106729;10766.784664306826;10771.46142692878;10184.134348580454;10299.897001029894;10447.373157610567;10553.419561924167;10846.566137354734;8847.336449766422;8922.509261990654;9245.768855778659;9372;9403.576839042124;8253;8547.871781923152;8634;8738.868916966123;8779.25376343018 02:41:45 INFO - PROCESS | 3532 | __end_tp_report 02:41:45 INFO - PROCESS | 3532 | __start_cc_report 02:41:45 INFO - PROCESS | 3532 | _x_x_mozilla_cycle_collect,396 02:41:45 INFO - PROCESS | 3532 | __end_cc_report 02:41:45 INFO - PROCESS | 3532 | __startTimestamp1468748505308__endTimestamp 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | ------- Summary: start ------- 02:41:45 INFO - PROCESS | 3532 | Number of tests: 6 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#0] dojo.html Cycles:165 Average:4759.32 Median:4906.39 stddev:502.18 (10.2%) stddev-sans-first:475.08 02:41:45 INFO - PROCESS | 3532 | Values: 2627.9 2662.6 2692.2 2701.1 2702.1 4775.1 4792.4 4808.6 4859.8 4916.6 4632.1 4784.3 4807.5 4824.0 4825.4 4379.1 4404.1 4490.3 4512.8 4525.8 4201.4 4452.9 4462.0 4524.6 4530.3 4326.8 4338.0 4397.6 4398.1 4463.1 4379.7 4386.6 4414.2 4422.5 4447.9 4388.3 4412.4 4421.2 4442.4 4449.7 4712.5 4776.5 4781.9 4797.9 4803.6 5126.1 5138.2 5144.4 5152.5 5207.4 5143.3 5158.4 5185.1 5190.9 5210.2 4836.3 4843.4 4844.7 4844.9 4899.7 5325.2 5330.9 5332.0 5336.4 5354.0 4981.1 4985.2 4987.2 5022.9 5084.5 4985.5 5067.0 5096.9 5105.6 5112.4 5056.0 5063.2 5089.9 5111.5 5113.1 4946.7 5005.7 5057.5 5090.8 5133.8 4392.2 4402.6 4443.2 4445.2 4450.0 3764.6 3778.0 3788.7 3835.5 3855.8 4251.0 4407.8 4413.2 4418.8 4425.1 5218.7 5235.9 5266.0 5275.4 5284.7 4454.6 4456.0 4457.3 4495.8 4529.4 4536.9 4658.3 4671.9 4674.7 4702.4 4848.3 4893.9 4919.7 4936.0 4984.9 5160.0 5189.5 5193.7 5217.4 5247.6 4775.5 4841.6 4880.5 4906.4 4907.9 5061.5 5091.7 5100.0 5102.8 5133.2 5065.1 5078.4 5118.2 5165.8 5170.8 4905.9 4987.0 4990.2 5000.0 5028.9 5041.4 5062.8 5065.8 5070.4 5127.8 4791.3 4911.0 4921.4 4935.4 4975.3 5050.0 5054.7 5062.6 5072.5 5111.0 4861.3 4920.9 4922.1 4940.9 4941.6 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#1] ext.html Cycles:180 Average:48569.28 Median:36236.55 stddev:93555.92 (258.2%) stddev-sans-first:93748.93 02:41:45 INFO - PROCESS | 3532 | Values: 559.7 564.6 575.5 587.7 604.7 34842.8 38058.2 38264.6 38279.6 38302.2 38523.4 39141.0 39187.0 39206.0 39373.4 7552.7 7669.5 7690.3 7699.2 7754.7 7698.2 7761.5 7787.6 7800.0 7803.0 7808.2 7814.2 7846.7 7855.4 7867.4 7736.6 7766.5 7778.1 7780.9 7785.1 7663.0 7758.5 7759.8 7765.7 7786.0 35258.1 36136.8 36173.3 36214.3 36224.3 2799.1 2857.6 2904.2 2970.0 2995.4 29060.3 29151.3 29393.7 29855.7 29938.1 3319.1 3396.3 3407.1 3442.2 3473.0 252852.0 253580.0 254012.0 255006.0 255277.0 32984.0 34114.0 50884.7 51459.5 51522.0 33628.8 33839.8 33891.7 33940.0 33978.3 12309.1 12348.6 12364.6 12381.3 12387.5 10725.8 10797.4 10801.0 10825.9 10831.7 7833.6 7851.8 7857.1 7906.1 7956.8 3095.5 3117.3 3136.7 3166.6 3220.1 857.6 875.4 896.2 921.0 997.4 27729.0 28080.3 28394.9 28633.7 28728.3 916.3 924.9 969.6 1008.2 1029.1 14737.7 14743.6 14809.0 14877.4 15023.6 405084.0 405414.0 407460.0 408306.0 409232.0 47873.5 48195.3 48426.8 48516.8 48807.8 1186.0 1205.7 1206.8 1220.7 1222.1 25744.4 26869.7 27497.3 27674.7 27694.0 42463.0 46855.0 46863.3 46879.3 46932.3 376230.0 378715.0 381089.0 381270.0 382700.0 24861.9 25784.9 37768.6 38273.4 38370.8 41026.0 41294.6 41375.2 41496.8 41603.8 35380.5 35606.0 36025.6 36050.0 36340.5 36248.8 36584.0 36786.4 36797.1 36813.8 34288.5 34482.0 35295.5 35358.5 35671.8 31405.8 32142.7 32604.3 32629.3 32635.8 25069.2 25075.9 25173.2 25441.3 25806.6 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#2] jquery.html Cycles:180 Average:23615.51 Median:5343.36 stddev:64095.31 (1199.5%) stddev-sans-first:64251.37 02:41:45 INFO - PROCESS | 3532 | Values: 379.0 379.4 380.7 388.9 395.2 16102.9 17304.6 17598.3 18277.2 18285.6 17137.1 17281.0 17372.1 17463.7 17523.5 5040.4 5224.5 5250.1 5252.0 5256.3 3830.7 5726.4 6030.9 6042.2 6154.0 5091.6 6081.3 6086.3 6098.8 6118.7 5244.5 5327.2 5346.0 5356.0 5360.4 5204.1 5340.7 5351.6 5352.4 5441.2 11426.5 11528.4 11601.2 11639.1 11661.6 1741.3 1819.1 1891.7 2006.9 2403.8 9095.6 9099.1 9106.5 9455.9 9698.6 1726.2 1731.7 1771.5 1795.5 1850.8 61523.7 61936.7 64183.6 64347.4 69197.0 10009.3 10098.4 10246.4 10271.4 10372.8 14063.6 14105.7 14165.9 14199.8 14213.9 6798.4 7194.2 7270.3 7365.8 7393.0 6876.2 6903.5 6940.3 7047.3 7079.5 4394.6 4402.6 4416.1 4444.6 4538.4 1694.3 1708.6 1832.3 1884.6 1930.4 816.6 818.3 837.6 841.3 962.2 16610.5 17119.4 17139.4 17249.5 17407.2 840.7 845.6 878.9 919.7 939.6 9347.5 9593.4 9726.2 9787.9 9889.4 383900.0 384160.4 385829.0 387714.0 401710.0 71491.6 71576.6 71978.6 75008.6 75503.0 904.3 906.5 908.8 921.1 923.1 15238.1 15286.2 15337.9 15390.3 15806.7 36719.3 37314.6 37602.0 37954.1 38293.4 49218.5 50862.2 51391.2 51610.7 51715.2 4336.8 4481.7 5888.7 6311.2 7050.8 7923.6 8042.9 9256.3 10639.9 10739.7 9283.9 9499.4 9549.0 9558.5 9620.6 9048.5 9067.2 9278.1 9310.7 9335.6 5492.7 5628.9 9206.5 9822.3 10158.7 7218.6 7252.9 7270.5 7373.0 7464.5 9728.1 9731.8 9761.5 9762.8 9969.5 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#3] mootools.html Cycles:180 Average:5235.50 Median:5177.73 stddev:2943.83 (56.9%) stddev-sans-first:2937.77 02:41:45 INFO - PROCESS | 3532 | Values: 1371.6 1413.1 1501.3 1607.3 1719.9 6850.3 7475.7 7541.2 8010.3 8040.0 7682.2 7855.5 7917.2 7921.5 7922.7 2163.4 2187.0 2197.4 2203.5 2205.8 2123.8 2145.0 2218.3 2219.1 2230.7 2130.0 2136.8 2150.8 2151.5 2170.7 2133.6 2141.5 2141.6 2143.0 2145.2 2051.7 2069.2 2069.3 2084.2 2084.4 7908.8 7984.0 7990.2 8004.4 8020.0 4611.4 4741.4 4754.0 4756.4 4756.9 2970.6 3003.5 3005.1 3032.9 3120.6 899.1 954.6 963.4 967.7 990.8 10595.8 10712.0 10749.7 10827.9 10854.0 4062.6 4155.2 4277.1 4278.2 4284.6 9174.8 9202.6 9258.9 9269.0 9289.8 4696.4 4711.8 4721.0 4730.9 4736.0 3660.2 4100.5 4229.7 4307.5 4309.1 3712.6 3721.1 3731.5 3803.7 3844.9 1187.5 1211.4 1226.8 1233.6 1245.0 843.6 856.8 858.8 891.4 896.6 5475.7 5489.7 5505.7 5521.8 5898.9 886.3 899.6 927.8 953.9 1002.5 3617.3 3641.3 3735.7 3802.5 3812.7 9700.4 9922.8 10022.4 10027.3 10035.6 9856.2 9952.6 9973.7 9991.9 10021.4 7365.6 7554.1 7569.7 7589.4 7620.2 5140.4 5215.1 5228.8 5380.3 5448.6 9210.5 9309.7 9343.6 9347.2 9374.0 8753.7 9107.0 9115.0 9342.5 9426.0 6073.9 6320.9 6493.5 6662.0 6876.2 7624.3 7685.2 7707.4 7755.4 7760.6 6869.3 6970.9 7069.4 7154.4 7180.1 6925.5 6949.0 6973.9 6975.9 7037.1 6299.4 6302.1 6310.1 6310.6 6318.2 4545.3 4547.1 4639.7 4661.7 4669.6 4544.1 4603.6 4655.5 4679.2 4697.2 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#4] prototype.html Cycles:180 Average:4246.90 Median:4576.01 stddev:1218.47 (26.6%) stddev-sans-first:1185.15 02:41:45 INFO - PROCESS | 3532 | Values: 290.6 304.1 306.2 307.1 313.1 4872.9 4938.4 5029.6 5107.4 5119.3 5002.9 5016.2 5017.3 5042.5 5043.8 3956.6 3966.1 3969.7 3971.8 3985.8 3920.3 3969.7 3977.2 3981.5 3983.1 3935.9 3941.2 3951.1 3964.5 3970.3 3935.8 3937.4 3940.4 3951.6 3962.4 3495.0 3497.6 3505.5 3506.5 3514.3 4881.6 4966.4 4966.9 4982.3 5029.2 4529.4 4540.5 4543.6 4566.5 4578.4 5280.9 5314.3 5337.7 5344.3 5372.4 3697.0 3805.9 3827.5 3837.1 3847.8 5571.4 5577.5 5585.5 5590.6 5640.1 3915.3 3925.3 3930.0 3949.0 3957.2 3698.6 4002.0 4007.6 4008.7 4009.6 4496.3 4496.7 4498.0 4511.2 4531.9 5297.2 5341.9 5382.0 5388.8 5399.6 1274.0 1365.8 1376.1 1384.5 1389.2 964.9 968.7 981.7 984.9 996.0 4014.6 4050.5 4093.3 4110.4 4110.7 4764.8 4826.7 4849.8 4857.2 4866.7 4087.8 4096.8 4097.8 4113.9 4138.9 2496.5 2573.3 2584.6 2594.9 2604.8 4510.5 4573.6 4592.6 4596.4 4624.7 4889.9 4894.7 4894.9 4902.2 4921.4 4387.6 4452.6 4535.9 4541.5 4563.7 4782.3 4824.4 4834.8 4855.3 4872.6 4687.1 4725.5 4762.9 4770.2 4784.3 4306.0 4503.8 4546.4 4551.9 4565.9 3596.4 3630.8 3643.8 3676.5 3686.8 4877.8 4908.7 4922.0 5235.3 5382.0 5307.8 5331.1 5331.7 5344.4 5375.2 5314.5 5322.5 5328.1 5329.7 5352.6 5084.8 5225.9 5253.6 5255.4 5266.3 5336.4 5376.0 5381.2 5383.5 5392.7 5233.8 5246.9 5281.4 5281.9 5304.8 02:41:45 INFO - PROCESS | 3532 | 02:41:45 INFO - PROCESS | 3532 | [#5] yui.html Cycles:180 Average:14930.89 Median:533.50 stddev:20463.64 (3835.7%) stddev-sans-first:20492.72 02:41:45 INFO - PROCESS | 3532 | Values: 591.4 642.1 646.7 648.2 674.3 12959.7 13927.0 13981.0 13981.7 14012.9 11707.4 11725.1 11988.7 12092.4 12129.2 758.8 779.6 782.1 787.6 789.1 757.0 761.8 763.7 763.9 765.5 823.8 824.3 827.1 828.9 829.8 811.9 812.7 813.9 814.4 819.5 595.4 598.4 601.4 603.2 605.0 11609.4 11635.7 11711.8 11746.3 11780.9 10041.1 10130.9 10198.9 10277.4 10450.8 8868.2 9280.0 9512.6 9531.6 9636.1 3082.0 3112.9 3124.0 3127.7 3138.5 40360.8 55205.7 55777.0 59992.0 60053.4 9057.5 9195.4 9633.4 9705.3 10459.6 17321.2 17440.5 17468.7 17505.5 17546.4 5862.8 5889.1 5950.4 5967.9 6010.5 3453.2 3468.8 3502.0 3530.0 3653.0 2854.1 2960.0 2965.6 2966.4 2973.7 519.2 523.7 529.6 530.7 534.5 479.2 525.5 532.5 544.9 549.4 6948.3 7025.6 7036.4 7047.8 7384.3 449.3 548.7 551.0 561.4 569.4 3101.3 3151.3 3196.9 3215.3 3317.5 54699.7 55495.4 76182.0 80260.0 80922.2 49414.5 60498.0 70738.0 71642.0 80034.6 67414.0 73280.6 75300.2 76846.0 76901.6 7699.4 7987.6 8040.2 8110.9 8260.2 32232.7 38741.6 41660.2 43296.6 43984.3 36428.6 37039.8 37155.8 37358.6 40534.2 10576.5 10587.4 10631.1 10669.2 10847.9 11153.7 11339.4 11547.4 11656.0 12014.0 10457.7 10457.9 10790.7 10838.9 11244.9 10274.1 10298.3 10673.9 10766.8 10771.5 10184.1 10299.9 10447.4 10553.4 10846.6 8847.3 8922.5 9245.8 9372.0 9403.6 8253.0 8547.9 8634.0 8738.9 8779.3 02:41:45 INFO - PROCESS | 3532 | -------- Summary: end -------- 02:41:45 INFO - PROCESS | 3532 | 02:41:46 INFO - TEST-INFO | 3532: exit 0 02:41:46 INFO - TEST-OK | dromaeo_css | took 1120186ms 02:41:46 INFO - TEST-START | kraken 02:41:46 INFO - operating with platform_type : linux_ 02:41:46 INFO - Initialising browser for kraken test... 02:41:46 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSOhpj4/profile http://localhost:54248/getInfo.html) 02:41:49 INFO - PROCESS | 3777 | JavaScript error: , line 0: uncaught exception: undefined 02:41:51 INFO - PROCESS | 3777 | __metrics Screen width/height:1600/1200 02:41:51 INFO - PROCESS | 3777 | colorDepth:24 02:41:51 INFO - PROCESS | 3777 | Browser inner width/height: 1024/697 02:41:51 INFO - PROCESS | 3777 | __metrics 02:41:51 ERROR - PROCESS | 3777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:41:52 INFO - TEST-INFO | 3777: exit 0 02:41:52 INFO - Browser initialized. 02:41:52 INFO - Running cycle 1/1 for kraken test... 02:41:52 INFO - TEST-INFO | started process 3899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSOhpj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:04 INFO - PROCESS | 3899 | RSS: Main: 169877504 02:42:04 INFO - PROCESS | 3899 | 02:42:07 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54248/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:08 INFO - PROCESS | 3899 | RSS: Main: 175214592 02:42:08 INFO - PROCESS | 3899 | 02:42:10 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54248/tests/kraken/driver.html?testName=audio-dft) 02:42:11 INFO - PROCESS | 3899 | RSS: Main: 174948352 02:42:11 INFO - PROCESS | 3899 | 02:42:14 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54248/tests/kraken/driver.html?testName=audio-fft) 02:42:15 INFO - PROCESS | 3899 | RSS: Main: 168796160 02:42:15 INFO - PROCESS | 3899 | 02:42:17 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54248/tests/kraken/driver.html?testName=audio-oscillator) 02:42:17 INFO - PROCESS | 3899 | RSS: Main: 170512384 02:42:17 INFO - PROCESS | 3899 | 02:42:20 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:20 INFO - PROCESS | 3899 | RSS: Main: 170274816 02:42:20 INFO - PROCESS | 3899 | 02:42:23 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54248/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:24 INFO - PROCESS | 3899 | RSS: Main: 170651648 02:42:24 INFO - PROCESS | 3899 | 02:42:28 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54248/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:28 INFO - PROCESS | 3899 | RSS: Main: 168202240 02:42:28 INFO - PROCESS | 3899 | 02:42:31 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54248/tests/kraken/driver.html?testName=json-parse-financial) 02:42:32 INFO - PROCESS | 3899 | RSS: Main: 169603072 02:42:32 INFO - PROCESS | 3899 | 02:42:34 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:34 INFO - PROCESS | 3899 | RSS: Main: 169664512 02:42:34 INFO - PROCESS | 3899 | 02:42:36 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:37 INFO - PROCESS | 3899 | RSS: Main: 170352640 02:42:37 INFO - PROCESS | 3899 | 02:42:39 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:40 INFO - PROCESS | 3899 | RSS: Main: 170364928 02:42:40 INFO - PROCESS | 3899 | 02:42:42 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:43 INFO - PROCESS | 3899 | RSS: Main: 171347968 02:42:43 INFO - PROCESS | 3899 | 02:42:46 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:47 INFO - PROCESS | 3899 | RSS: Main: 171053056 02:42:47 INFO - PROCESS | 3899 | 02:42:48 INFO - PROCESS | 3899 | Cycle 1(1): loaded http://localhost:54248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54248/tests/kraken/driver.html?testName=ai-astar) 02:42:49 INFO - PROCESS | 3899 | RSS: Main: 171429888 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | __start_tp_report 02:42:49 INFO - PROCESS | 3899 | _x_x_mozilla_page_load 02:42:49 INFO - PROCESS | 3899 | _x_x_mozilla_page_load_details 02:42:49 INFO - PROCESS | 3899 | |i|pagename|runs| 02:42:49 INFO - PROCESS | 3899 | |0;ai-astar;106;115;109;116;115;115;115;115;114;113 02:42:49 INFO - PROCESS | 3899 | |1;audio-beat-detection;151;123;148;168;129;157;154;125;195;128 02:42:49 INFO - PROCESS | 3899 | |2;audio-dft;163;163;162;165;170;163;162;164;164;161 02:42:49 INFO - PROCESS | 3899 | |3;audio-fft;76;78;78;135;78;76;77;78;164;78 02:42:49 INFO - PROCESS | 3899 | |4;audio-oscillator;85;86;144;85;85;85;131;86;85;145 02:42:49 INFO - PROCESS | 3899 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;118;118;117 02:42:49 INFO - PROCESS | 3899 | |6;imaging-darkroom;148;148;148;148;149;149;147;148;148;147 02:42:49 INFO - PROCESS | 3899 | |7;imaging-desaturate;98;96;95;96;97;96;95;95;97;95 02:42:49 INFO - PROCESS | 3899 | |8;json-parse-financial;63;63;64;63;65;62;62;63;62;64 02:42:49 INFO - PROCESS | 3899 | |9;json-stringify-tinderbox;67;68;69;67;66;66;66;65;66;67 02:42:49 INFO - PROCESS | 3899 | |10;stanford-crypto-aes;80;78;79;88;80;78;88;79;90;85 02:42:49 INFO - PROCESS | 3899 | |11;stanford-crypto-ccm;139;139;137;146;130;129;128;134;168;135 02:42:49 INFO - PROCESS | 3899 | |12;stanford-crypto-pbkdf2;173;169;164;163;162;163;164;163;166;167 02:42:49 INFO - PROCESS | 3899 | |13;stanford-crypto-sha256-iterative;68;66;71;65;68;65;68;66;69;69 02:42:49 INFO - PROCESS | 3899 | __end_tp_report 02:42:49 INFO - PROCESS | 3899 | __start_cc_report 02:42:49 INFO - PROCESS | 3899 | _x_x_mozilla_cycle_collect,1015 02:42:49 INFO - PROCESS | 3899 | __end_cc_report 02:42:49 INFO - PROCESS | 3899 | __startTimestamp1468748569068__endTimestamp 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | ------- Summary: start ------- 02:42:49 INFO - PROCESS | 3899 | Number of tests: 14 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.23 (2.8%) stddev-sans-first:2.09 02:42:49 INFO - PROCESS | 3899 | Values: 106.0 115.0 109.0 116.0 115.0 115.0 115.0 115.0 114.0 113.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.50 stddev:22.73 (14.9%) stddev-sans-first:24.08 02:42:49 INFO - PROCESS | 3899 | Values: 151.0 123.0 148.0 168.0 129.0 157.0 154.0 125.0 195.0 128.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.50 (1.5%) stddev-sans-first:2.64 02:42:49 INFO - PROCESS | 3899 | Values: 163.0 163.0 162.0 165.0 170.0 163.0 162.0 164.0 164.0 161.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#3] audio-fft Cycles:10 Average:91.80 Median:78.00 stddev:31.18 (40.0%) stddev-sans-first:32.54 02:42:49 INFO - PROCESS | 3899 | Values: 76.0 78.0 78.0 135.0 78.0 76.0 77.0 78.0 164.0 78.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:85.00 stddev:26.69 (31.4%) stddev-sans-first:27.61 02:42:49 INFO - PROCESS | 3899 | Values: 85.0 86.0 144.0 85.0 85.0 85.0 131.0 86.0 85.0 145.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:42:49 INFO - PROCESS | 3899 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:42:49 INFO - PROCESS | 3899 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 147.0 148.0 148.0 147.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.05 (1.1%) stddev-sans-first:0.83 02:42:49 INFO - PROCESS | 3899 | Values: 98.0 96.0 95.0 96.0 97.0 96.0 95.0 95.0 97.0 95.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 02:42:49 INFO - PROCESS | 3899 | Values: 63.0 63.0 64.0 63.0 65.0 62.0 62.0 63.0 62.0 64.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 02:42:49 INFO - PROCESS | 3899 | Values: 67.0 68.0 69.0 67.0 66.0 66.0 66.0 65.0 66.0 67.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:4.72 (5.7%) stddev-sans-first:4.92 02:42:49 INFO - PROCESS | 3899 | Values: 80.0 78.0 79.0 88.0 80.0 78.0 88.0 79.0 90.0 85.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:138.00 stddev:11.71 (8.5%) stddev-sans-first:12.42 02:42:49 INFO - PROCESS | 3899 | Values: 139.0 139.0 137.0 146.0 130.0 129.0 128.0 134.0 168.0 135.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.00 stddev:3.44 (2.1%) stddev-sans-first:2.30 02:42:49 INFO - PROCESS | 3899 | Values: 173.0 169.0 164.0 163.0 162.0 163.0 164.0 163.0 166.0 167.0 02:42:49 INFO - PROCESS | 3899 | 02:42:49 INFO - PROCESS | 3899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:2.07 02:42:49 INFO - PROCESS | 3899 | Values: 68.0 66.0 71.0 65.0 68.0 65.0 68.0 66.0 69.0 69.0 02:42:49 INFO - PROCESS | 3899 | -------- Summary: end -------- 02:42:49 INFO - PROCESS | 3899 | 02:42:50 INFO - TEST-INFO | 3899: exit 0 02:42:50 INFO - TEST-OK | kraken | took 64029ms 02:42:50 INFO - SUITE-END | took 1184s 02:42:50 INFO - Completed test suite (00:19:44) 02:42:50 INFO - javascript benchmark 02:42:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6255.095628501942, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.947441051179, 2662.58729896866, 2692.151972128778, 2701.0816322450373, 2702.081292360597, 4775.06886157199, 4792.424909010919, 4808.591269742072, 4859.757012149396, 4916.582090522301, 4632.07358528294, 4784.258439941815, 4807.543283388081, 4824.035192961413, 4825.396825396825, 4379.058502421979, 4404.053128577355, 4490.326451032339, 4512.819487220524, 4525.773711314438, 4201.411802347674, 4452.933206001912, 4461.977690111545, 4524.6380289576755, 4530.32045193222, 4326.762028088454, 4338.002259480306, 4397.5602439756085, 4398.054418300049, 4463.085067561142, 4379.737215767064, 4386.56134386562, 4414.183376075404, 4422.491413487458, 4447.866564003085, 4388.275934470808, 4412.426384570017, 4421.159979603865, 4442.444694413199, 4449.6662750293535, 4712.528747125294, 4776.522347765231, 4781.928271075902, 4797.880052998668, 4803.591694705954, 5126.077306084903, 5138.203578445309, 5144.408393034774, 5152.484751524855, 5207.4011488678525, 5143.305653736773, 5158.432572417031, 5185.118529849935, 5190.92213616796, 5210.166373380279, 4836.322914791932, 4843.39457567804, 4844.709317440965, 4844.861457557542, 4899.730514821684, 5325.227841962971, 5330.92003619946, 5332.0, 5336.4129945705945, 5354.0, 4981.12830254704, 4985.177445721415, 4987.152184128707, 5022.949770502249, 5084.542391184737, 4985.52637499437, 5066.9746651266505, 5096.923546146811, 5105.566026887682, 5112.437631860493, 5055.974720126376, 5063.164577844688, 5089.898202036013, 5111.488851114933, 5113.079645663816, 4946.678465899705, 5005.6996580205305, 5057.468965758616, 5090.821821236313, 5133.768980395891, 4392.1874453226255, 4402.591170825369, 4443.178012067778, 4445.155420470101, 4449.9555004450185, 3764.5670747863796, 3778.0, 3788.6969042476535, 3835.53973523179, 3855.845766169322, 4251.043515209115, 4407.757573333433, 4413.249747542925, 4418.779061046999, 4425.137098265872, 5218.739063046833, 5235.947640523546, 5265.973670131625, 5275.366955965309, 5284.735763211824, 4454.5990860822685, 4455.9554404456185, 4457.286834106528, 4495.820167193276, 4529.365888775574, 4536.886577835515, 4658.324542941255, 4671.883202919887, 4674.672772905864, 4702.365180700562, 4848.272759086024, 4893.926591101065, 4919.680220785637, 4936.0, 4984.900301993867, 5159.974200128975, 5189.471904861327, 5193.662411943212, 5217.426083130928, 5247.55395791362, 4775.474697783172, 4841.636877234151, 4880.46314905353, 4906.386701662293, 4907.852764417074, 5061.4938506150565, 5091.694498330112, 5100.0, 5102.770375333044, 5133.178691409356, 5065.113605119163, 5078.390593128848, 5118.206677964921, 5165.819196328111, 5170.767315470737, 4905.9018819624125, 4986.975065124651, 4990.226514890198, 4999.950000500094, 5028.899422011613, 5041.42023667283, 5062.772175252197, 5065.797368105234, 5070.442251352422, 5127.79488820443, 4791.305260737243, 4910.975445122752, 4921.409430868319, 4935.383077115361, 4975.278584605285, 5050.04049230645, 5054.69671819692, 5062.645614806928, 5072.492750724898, 5111.028904508132, 4861.319415281934, 4920.8769780755765, 4922.138625740553, 4940.851774446773, 4941.555260026615], "value": 4726.98162518365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6697948210555, 564.559643478087, 575.470567078288, 587.7237698281806, 604.6704546022418, 34842.825785871064, 38058.23883522335, 38264.617353826456, 38279.61720382799, 38302.23395532091, 38523.42214866779, 39141.0, 39187.0, 39206.0, 39373.40939885897, 7552.69789208431, 7669.539827610333, 7690.3078722914925, 7699.230076992284, 7754.651040703154, 7698.191689872567, 7761.456698031112, 7787.610619469032, 7800.0, 7803.0, 7808.1801410851895, 7814.218578142197, 7846.72536461224, 7855.371570274393, 7867.449278550504, 7736.64608693482, 7766.456348055638, 7778.105517865433, 7780.8832867507035, 7785.065792104927, 7663.0, 7758.534487930742, 7759.806004849867, 7765.650545725456, 7786.0, 35258.118547036276, 36136.819315903515, 36173.27653446943, 36214.275714485826, 36224.275514489826, 2799.118277742525, 2857.6427946506687, 2904.2158617173454, 2970.0495841330785, 2995.3859458810894, 29060.27349316284, 29151.271218219503, 29393.70606293931, 29855.701442985508, 29938.101856944108, 3319.1204330852343, 3396.28677977625, 3407.148212946763, 3442.225499262671, 3472.9826350868084, 252852.0, 253580.0, 254012.0, 255006.0, 255277.0, 32984.0, 34114.0, 50884.74557627188, 51459.48540514622, 51522.0, 33628.831855840566, 33839.83080084584, 33891.66108338885, 33940.0, 33978.32043359168, 12309.076819238593, 12348.629541113782, 12364.62906112818, 12381.319027453397, 12387.504499820086, 10725.83911241332, 10797.352158870493, 10801.0, 10825.891741082645, 10831.729206769736, 7833.569153696488, 7851.764447066597, 7857.096433910059, 7906.130325664172, 7956.840863182704, 3095.5141532064736, 3117.3191055692087, 3136.7333776628784, 3166.6358368787883, 3220.0822765511716, 857.562643052048, 875.4047247871381, 896.1576118448637, 920.9685152629098, 997.3716558568055, 27729.0, 28080.29799255035, 28394.85802570974, 28633.71366286352, 28728.281792955342, 916.2715641065369, 924.893637231727, 969.6315400147898, 1008.2186305613209, 1029.1098200057047, 14737.705245895022, 14743.631409214855, 14809.0, 14877.404903803726, 15023.624409389853, 405084.0, 405414.0, 407460.0, 408306.0, 409232.0, 47873.5212647876, 48195.277070843964, 48426.75786621115, 48516.7574162134, 48807.755961220675, 1185.964421067352, 1205.662414523917, 1206.7586482703318, 1220.6765207220094, 1222.0712258683463, 25744.356391089623, 26869.731302686723, 27497.31256718598, 27674.723252767213, 27694.0, 42463.0, 46855.0, 46863.29705054495, 46879.29681054719, 46932.29601555911, 376230.0, 378715.0, 381089.0, 381270.0, 382700.0, 24861.87569062143, 25784.871075644503, 37768.62231377651, 38273.4258986121, 38370.80814595909, 41026.0, 41294.58705413028, 41375.172496550505, 41496.792516037225, 41603.7919810399, 35380.46929296114, 35606.0, 36025.63974360223, 36050.0, 36340.454893176095, 36248.81875590711, 36584.0, 36786.448203276435, 36797.08007299839, 36813.81593092017, 34288.48567271443, 34482.0, 35295.47056794099, 35358.46962295619, 35671.82164089163, 31405.842970785, 32142.67857321397, 32604.347913041132, 32629.34741305208, 32635.836820815744, 25069.247922562354, 25075.87462062678, 25173.24480265595, 25441.330213570818, 25806.61290080613], "value": 16503.565830925207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.95452545694513, 379.41380567023947, 380.7144641518859, 388.92610404023253, 395.17605791923836, 16102.919485402572, 17304.56738581536, 17598.296068157273, 18277.1775270113, 18285.634287314246, 17137.057461839595, 17281.04954227517, 17372.13139343034, 17463.650726985485, 17523.474295771117, 5040.445550989379, 5224.4775522447835, 5250.081235783722, 5252.028374750665, 5256.342957130359, 3830.674392676612, 5726.3700992890745, 6030.909536356936, 6042.184305118819, 6153.969230153843, 5091.567216786578, 6081.270247570275, 6086.330503644617, 6098.817035488943, 6118.663473508956, 5244.475552444763, 5327.200919862013, 5346.010987967238, 5356.0, 5360.437154098822, 5204.115300398941, 5340.706261155635, 5351.598630102719, 5352.411234764173, 5441.238226648273, 11426.485808138654, 11528.42357882111, 11601.187916845824, 11639.127065470124, 11661.591844285409, 1741.2860727101827, 1819.0995457248746, 1891.7446144770418, 2006.9096890639955, 2403.8437501562344, 9095.59069841852, 9099.135582119688, 9106.499142547158, 9455.858162127573, 9698.642190093393, 1726.240454200148, 1731.7402389641654, 1771.5393997560598, 1795.542136755132, 1850.82472629881, 61523.692381538254, 61936.69031654813, 64183.591463354176, 64347.3565264346, 69197.0, 10009.299349045643, 10098.394096354095, 10246.385216886862, 10271.435071071162, 10372.844407333896, 14063.578092657237, 14105.717885642229, 14165.929170354082, 14199.78700319496, 14213.928930355489, 6798.388145066968, 7194.20863704992, 7270.3456688897195, 7365.7790266292095, 7393.0, 6876.209235937931, 6903.482238832108, 6940.305969403019, 7047.330503602149, 7079.539829911039, 4394.582514661102, 4402.625776808943, 4416.050549131888, 4444.577765112309, 4538.364628951949, 1694.2799310293321, 1708.5643160993866, 1832.3495159218553, 1884.6136542008855, 1930.4328819385898, 816.5508970066439, 818.29217726666, 837.6314421654574, 841.2849078283532, 962.2446379591987, 16610.501684949228, 17119.400820971205, 17139.400120995706, 17249.482515524553, 17407.216675249645, 840.7141571865473, 845.572985642259, 878.9428687135315, 919.70569417787, 939.6100618243353, 9347.485888276211, 9593.42439453635, 9726.221902247804, 9787.90212097884, 9889.357191782512, 383900.0, 384160.3959901025, 385829.0, 387714.0, 401710.0, 71491.64254178696, 71576.64211678908, 71978.64010680017, 75008.62495687486, 75503.0, 904.3398319227001, 906.4878343735768, 908.8091500784909, 921.1387352824996, 923.1460898668705, 15238.085714857145, 15286.159261240738, 15337.923310383376, 15390.307436165176, 15806.683866322379, 36719.26561468809, 37314.6268537322, 37602.0, 37954.0511487204, 38293.42559861549, 49218.507814921395, 50862.23706644477, 51391.22913156381, 51610.74194629003, 51715.22427163671, 4336.807377971083, 4481.686281960231, 5888.705564721832, 6311.201307627304, 7050.823729406806, 7923.564203968837, 8042.919570804217, 9256.305777066613, 10639.89360106389, 10739.731506712395, 9283.907160928304, 9499.43003419797, 9549.0, 9558.522073896416, 9620.615175393186, 9048.547572621212, 9067.186562687357, 9278.11857873501, 9310.674126405544, 9335.57989890443, 5492.670439773627, 5628.887422251614, 9206.480930646369, 9822.263330250116, 10158.695239142837, 7218.566885986857, 7252.927470725225, 7270.527415717961, 7373.0, 7464.477486575887, 9728.075832795874, 9731.756706082404, 9761.518502532454, 9762.804743905224, 9969.451680157661], "value": 7896.854416388301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.609091408948, 1413.145047246416, 1501.2868887278544, 1607.2526275281991, 1719.853812425943, 6850.314968503148, 7475.73834915778, 7541.208173141817, 8010.279074883259, 8040.035195776508, 7682.231776822329, 7855.4893931894385, 7917.2082791720795, 7921.524708517493, 7922.683092676286, 2163.448320678229, 2186.967195492069, 2197.373748481683, 2203.526241858, 2205.8345624078256, 2123.766385697572, 2145.0454547726267, 2218.3123231798113, 2219.1012639880873, 2230.721159855018, 2130.0, 2136.839737019722, 2150.763416024236, 2151.494398816285, 2170.6852506386563, 2133.57328534293, 2141.5395689926586, 2141.625215587266, 2142.9785702142935, 2145.1633862793524, 2051.7332746742827, 2069.2033567076633, 2069.2757534862826, 2084.218418093215, 2084.3642688979853, 7908.762737117896, 7984.041914970183, 7990.240927111915, 8004.359651227888, 8020.0, 4611.377464042345, 4741.407324084489, 4753.952460475385, 4756.405449318835, 4756.904861902777, 2970.5544168374918, 3003.519436890087, 3005.0534081764176, 3032.924176895573, 3120.594322738052, 899.1458114790975, 954.5609019850876, 963.4026903319916, 967.6951760195516, 990.8216521026212, 10595.841062383994, 10712.0, 10749.731256718645, 10827.891721082768, 10854.0, 4062.6343629073526, 4155.168966206771, 4277.144571085795, 4278.187144442546, 4284.635805956528, 9174.816503669888, 9202.63189472427, 9258.861117083114, 9269.0, 9289.767755806024, 4696.436427628706, 4711.764411779397, 4720.976395118071, 4730.858074257778, 4735.976320118446, 3660.1581636223286, 4100.487439070116, 4229.703920725581, 4307.483102027777, 4309.1381723655395, 3712.6472985066375, 3721.14413684854, 3731.533558305212, 3803.7337386382687, 3844.9038774030873, 1187.4834447015576, 1211.4432953654511, 1226.8282440458343, 1233.5620854596489, 1244.9688757781128, 843.6245870587529, 856.7815207122144, 858.8454078265972, 891.3893982621795, 896.5965315608003, 5475.7262136893, 5489.670619762827, 5505.6696598204235, 5521.834344969658, 5898.911516327258, 886.2776836877924, 899.6401439424283, 927.8097989912187, 953.909378609031, 1002.4562174251716, 3617.3127105849803, 3641.2717456508803, 3735.6824669902817, 3802.4676545283683, 3812.7140464465274, 9700.417974921527, 9922.751931201778, 10022.398656080659, 10027.348222365523, 10035.598576056876, 9856.162226210852, 9952.552135153936, 9973.650922217688, 9991.850122248172, 10021.448820314807, 7365.631718414058, 7554.055743032121, 7569.697212111454, 7589.392848572101, 7620.1998790127345, 5140.352718350127, 5215.113430716863, 5228.843134705965, 5380.273663055437, 5448.618596698193, 9210.493422861808, 9309.674161404319, 9343.626254949726, 9347.158755712018, 9373.953130234306, 8753.693620723245, 9107.0, 9115.0, 9342.486163261086, 9426.0, 6073.939260607337, 6320.905186422299, 6493.545451818327, 6662.034005069335, 6876.243613202644, 7624.27569380908, 7685.193054729397, 7707.421943354158, 7755.379569634529, 7760.611969401621, 6869.313068693091, 6970.930290697028, 7069.434445244471, 7154.39187669054, 7180.066591343092, 6925.515213935178, 6949.027136201037, 6973.860522789617, 6975.9302406975285, 7037.120359955005, 6299.433051025429, 6302.054691796267, 6310.05349197624, 6310.6213627182515, 6318.241810982711, 4545.340925565841, 4547.113312903952, 4639.744814035261, 4661.720296782204, 4669.556392142741, 4544.091181763727, 4603.58567728906, 4655.464621568563, 4679.181143299841, 4697.201475749062], "value": 4217.599311619788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.5598019001212, 304.0740943826049, 306.15806532036896, 307.0726406253116, 313.08735037366085, 4872.853814385565, 4938.407391113072, 5029.597632189425, 5107.438181800004, 5119.283300337951, 5002.949970500294, 5016.247562865572, 5017.272495488152, 5042.495750424956, 5043.823466178685, 3956.5647778744315, 3966.107625784204, 3969.7249768940596, 3971.7815520146382, 3985.8007099645047, 3920.2747491714126, 3969.6625786808154, 3977.2244412339605, 3981.5421226558883, 3983.1436241208135, 3935.9212815743667, 3941.1623630985787, 3951.111000025, 3964.5242570891533, 3970.285348637244, 3935.822887970048, 3937.4290727844586, 3940.4483372327895, 3951.6048395160396, 3962.3660214365564, 3494.9825250873837, 3497.6327485613897, 3505.509228707983, 3506.50908872758, 3514.332276867387, 4881.585065269456, 4966.355978667227, 4966.87582810429, 4982.302477653131, 5029.245613158056, 4529.365888775574, 4540.477845047796, 4543.613792827614, 4566.49768525462, 4578.427696537933, 5280.864614107947, 5314.335708036496, 5337.67973921562, 5344.305240318772, 5372.382176049726, 3697.0413730732184, 3805.904852378713, 3827.502424684801, 3837.0982819037504, 3847.7883716395586, 5571.359293681238, 5577.52591029763, 5585.469380408855, 5590.608657393984, 5640.125780504029, 3915.2952468555363, 3925.2924977634248, 3929.9607003929596, 3948.9605103949166, 3957.1689945111275, 3698.6486283802997, 4002.0, 4007.639312461834, 4008.679305655599, 4009.6190861868076, 4496.257283057333, 4496.651004698578, 4497.955020449819, 4511.1654343946475, 4531.864044078683, 5297.17893726473, 5341.946580534145, 5381.973090134525, 5388.8113916013535, 5399.595030372738, 1273.987260127387, 1365.7609918264463, 1376.0986553807272, 1384.5084994826893, 1389.208151353739, 964.875919553712, 968.7239136845965, 981.7251169672503, 984.9409035457752, 995.9890710928269, 4014.558398576154, 4050.4531888194715, 4093.3246014407887, 4110.383442483591, 4110.671146308288, 4764.76176191196, 4826.686265392808, 4849.756463094792, 4857.222844344888, 4866.732329721828, 4087.816048277835, 4096.836126554905, 4097.815598298083, 4113.85601503946, 4138.896527586834, 2496.450780828215, 2573.2794817451145, 2584.5993870950033, 2594.896204151813, 2604.8176627636262, 4510.526394728572, 4573.588377046015, 4592.563706447882, 4596.448426188812, 4624.699394539344, 4889.853304400874, 4894.730789806524, 4894.902101957941, 4902.240152776325, 4921.384826896638, 4387.639831652198, 4452.621527170162, 4535.909281814411, 4541.545845415498, 4563.691323790292, 4782.282657601388, 4824.445188803333, 4834.791302174456, 4855.271709243641, 4872.610191184767, 4687.125149940051, 4725.503822098768, 4762.927911497134, 4770.165221086366, 4784.306275590089, 4306.0, 4503.842365517191, 4546.40896683429, 4551.886202844956, 4565.927007153383, 3596.4425514045365, 3630.8003059830908, 3643.799591022413, 3676.5220521332058, 3686.834092465899, 4877.756112194447, 4908.656394052382, 4921.966387058757, 5235.319408476874, 5381.973090134525, 5307.814226502054, 5331.1470164773455, 5331.733413329395, 5344.438833922382, 5375.193720941734, 5314.548263397654, 5322.4677532248015, 5328.067588172132, 5329.694224914766, 5352.598555108305, 5084.8220312288895, 5225.869353266199, 5253.632245742914, 5255.421903590678, 5266.34170728659, 5336.386315573759, 5376.0, 5381.165919282517, 5383.515483606494, 5392.703401312965, 5233.790648374023, 5246.921296180637, 5281.366236051698, 5281.920771188512, 5304.787808487617], "value": 3868.742824776316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4292707537227, 642.1459458919637, 646.7154452041102, 648.2383199740304, 674.2616834566148, 12959.74080518389, 13927.025108242415, 13981.0, 13981.720365592682, 14012.929935350308, 11707.414629268524, 11725.120615953794, 11988.700282492942, 12092.395380230975, 12129.150959432822, 758.7685755844465, 779.5790273252437, 782.0927723840347, 787.5747096567846, 789.0964845252183, 756.9924300756977, 761.7981234972737, 763.7479631721519, 763.8701420758457, 765.4985984180371, 823.7775800533852, 824.286991752136, 827.1315119124895, 828.9378296627747, 829.7801082713056, 811.8701007838747, 812.6911773526023, 813.8982627171604, 814.3810703865105, 819.4550623835142, 595.3718826637895, 598.3507893935085, 601.3535449391921, 603.1977469964936, 605.0349692240869, 11609.361485118316, 11635.650930472098, 11711.824322635168, 11746.29522228669, 11780.882191178065, 10041.146502547292, 10130.9493452533, 10198.898011019943, 10277.383356998604, 10450.79098418035, 8868.246199073086, 9280.0, 9512.571934262975, 9531.618735250582, 9636.084571965652, 3081.9691803082133, 3112.8754849805982, 3124.0, 3127.660527848727, 3138.497840345534, 40360.79819600913, 55205.723971380285, 55777.0, 59992.0, 60053.399466005656, 9057.456552606733, 9195.40229885049, 9633.421994680342, 9705.320627556004, 10459.581616735397, 17321.220545075503, 17440.47678569645, 17468.737968930476, 17505.474835754947, 17546.385876494518, 5862.765489380462, 5889.146073819272, 5950.404959504015, 5967.9257733608365, 6010.54920880927, 3453.223024819446, 3468.791872487659, 3501.9824900875333, 3530.0, 3652.981735091361, 2854.1152242804797, 2959.9704002960125, 2965.635807528561, 2966.391889662614, 2973.7323640872423, 519.1926554208243, 523.743365750787, 529.5736931769962, 530.729328042701, 534.4628648208526, 479.1925605354988, 525.5007742644503, 532.5446743034727, 544.8991936491761, 549.3823174396642, 6948.33990770876, 7025.5784652919965, 7036.401905838061, 7047.753328633473, 7384.26157384268, 449.341714388416, 548.6516062300389, 550.9696966666871, 561.3852831149884, 569.407815871489, 3101.3177101037736, 3151.306712523241, 3196.9360612787614, 3215.324781795802, 3317.4857897026, 54699.72650136804, 55495.44504554984, 76182.0, 80260.0, 80922.19077809264, 49414.50585494171, 60498.0, 70738.0, 71642.0, 80034.5998270005, 67414.0, 73280.63359683167, 75300.24699752932, 76846.0, 76901.61549192219, 7699.384049275933, 7987.600619968862, 8040.195980401913, 8110.905027821169, 8260.173982601691, 32232.677673222966, 38741.6125838738, 41660.1667966645, 43296.56703432925, 43984.34023489586, 36428.63571364252, 37039.81480092582, 37155.814220928725, 37358.6264137366, 40534.1893162141, 10576.524056417633, 10587.364758114538, 10631.096356809758, 10669.199810014436, 10847.891521085005, 11153.72115697114, 11339.433028348714, 11547.422628868691, 11656.0, 12014.0, 10457.68626941193, 10457.895421045996, 10790.73023174427, 10838.891611083789, 11244.887551124384, 10274.12669923035, 10298.330608510423, 10673.89326106729, 10766.784664306826, 10771.46142692878, 10184.134348580454, 10299.897001029894, 10447.373157610567, 10553.419561924167, 10846.566137354734, 8847.336449766422, 8922.509261990654, 9245.768855778659, 9372.0, 9403.576839042124, 8253.0, 8547.871781923152, 8634.0, 8738.868916966123, 8779.25376343018], "value": 5958.1028631002155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 109.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 148.0, 168.0, 129.0, 157.0, 154.0, 125.0, 195.0, 128.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 165.0, 170.0, 163.0, 162.0, 164.0, 164.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 135.0, 78.0, 76.0, 77.0, 78.0, 164.0, 78.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 85.0, 85.0, 85.0, 131.0, 86.0, 85.0, 145.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 62.0, 62.0, 63.0, 62.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 88.0, 80.0, 78.0, 88.0, 79.0, 90.0, 85.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 137.0, 146.0, 130.0, 129.0, 128.0, 134.0, 168.0, 135.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 164.0, 163.0, 162.0, 163.0, 164.0, 163.0, 166.0, 167.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 71.0, 65.0, 68.0, 65.0, 68.0, 66.0, 69.0, 69.0], "value": 67.5, "unit": "score"}]}]} 02:42:50 INFO - Return code: 0 02:42:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:50 ERROR - # TBPL SUCCESS # 02:42:50 INFO - Running post-action listener: _resource_record_post_action 02:42:50 INFO - ##### 02:42:50 INFO - ##### Finished run-tests step (success) 02:42:50 INFO - ##### 02:42:50 INFO - Running post-run listener: _resource_record_post_run 02:42:50 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 377323520; Read time: 1660; Write time: 378592 02:42:50 INFO - TinderboxPrint: CPU usage
13.4% 02:42:50 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 1,660 02:42:50 INFO - TinderboxPrint: I/O write bytes / time
377,323,520 / 378,592 02:42:50 INFO - TinderboxPrint: CPU idle
8,299.4 (86.6%) 02:42:50 INFO - TinderboxPrint: CPU user
1,228.4 (12.8%) 02:42:50 INFO - TinderboxPrint: Swap in / out
0 / 0 02:42:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 19505152; Read time: 0; Write time: 14908 02:42:50 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5701632; Write bytes: 331153408; Read time: 1308; Write time: 346916 02:42:51 INFO - Running post-run listener: _upload_blobber_files 02:42:51 INFO - Blob upload gear active. 02:42:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:51 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 02:42:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:42:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:52 INFO - (blobuploader) - INFO - Done attempting. 02:42:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:42:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:53 INFO - (blobuploader) - INFO - Done attempting. 02:42:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:00 INFO - (blobuploader) - INFO - Done attempting. 02:43:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:00 INFO - Return code: 0 02:43:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb836e6ea08b102f1096c081559274494bd0916a5a15d71288f5b2225196e6c0dca834b01ae35a71cdfcbc9820cc191d5601010c83e65f0df30d7be21d6e9d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/138f9458b31ed8f1bf9dd1b76630b62714e550666f96199a2ad6605f91040654eafb4d871de9c4dc216e03082fb24f7b9e2da86f99c6545e44c788918e3f7fda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3652e800e35d826df0ea0f368f64f3882f0af4ed35d55301141bc8c47e4cff9d86a381f527aadbc8dcea5505b01b65ad7af2cd11973b9b775298212b347e6d2b"} 02:43:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:00 INFO - Contents: 02:43:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb836e6ea08b102f1096c081559274494bd0916a5a15d71288f5b2225196e6c0dca834b01ae35a71cdfcbc9820cc191d5601010c83e65f0df30d7be21d6e9d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/138f9458b31ed8f1bf9dd1b76630b62714e550666f96199a2ad6605f91040654eafb4d871de9c4dc216e03082fb24f7b9e2da86f99c6545e44c788918e3f7fda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3652e800e35d826df0ea0f368f64f3882f0af4ed35d55301141bc8c47e4cff9d86a381f527aadbc8dcea5505b01b65ad7af2cd11973b9b775298212b347e6d2b"} 02:43:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:00 INFO - Copying logs to upload dir... 02:43:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.051942 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-17 02:43:00.540378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:43:00.544907) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 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-Non-PGO/sha512/bb836e6ea08b102f1096c081559274494bd0916a5a15d71288f5b2225196e6c0dca834b01ae35a71cdfcbc9820cc191d5601010c83e65f0df30d7be21d6e9d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/138f9458b31ed8f1bf9dd1b76630b62714e550666f96199a2ad6605f91040654eafb4d871de9c4dc216e03082fb24f7b9e2da86f99c6545e44c788918e3f7fda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3652e800e35d826df0ea0f368f64f3882f0af4ed35d55301141bc8c47e4cff9d86a381f527aadbc8dcea5505b01b65ad7af2cd11973b9b775298212b347e6d2b"} build_url:https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/KMD7fQ7qTUqtqTgAFFKnhA/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-Non-PGO/sha512/bb836e6ea08b102f1096c081559274494bd0916a5a15d71288f5b2225196e6c0dca834b01ae35a71cdfcbc9820cc191d5601010c83e65f0df30d7be21d6e9d5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/138f9458b31ed8f1bf9dd1b76630b62714e550666f96199a2ad6605f91040654eafb4d871de9c4dc216e03082fb24f7b9e2da86f99c6545e44c788918e3f7fda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3652e800e35d826df0ea0f368f64f3882f0af4ed35d55301141bc8c47e4cff9d86a381f527aadbc8dcea5505b01b65ad7af2cd11973b9b775298212b347e6d2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:43:00.576202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:43:00.580653) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468746679.944096-331370171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:43:00.634167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:43:00.636521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:43:00.636825) ========= ========= Total master_lag: 0.41 =========