builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1467289260.68 results: success (0) buildid: 20160630045127 builduid: 150ab89b60ae4c669abd09f5b250b7f5 revision: 5f550071f889ff522db03e1e8e86e4cea11b4962 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.684079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.684533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.684830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.713219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.713527) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:21:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2016-06-30 05:21:02 (45.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.849048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.849347) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023375 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.899809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:00.900153) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f550071f889ff522db03e1e8e86e4cea11b4962 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5f550071f889ff522db03e1e8e86e4cea11b4962 --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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:21:02,278 truncating revision to first 12 chars 2016-06-30 05:21:02,278 Setting DEBUG logging. 2016-06-30 05:21:02,278 attempt 1/10 2016-06-30 05:21:02,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f550071f889?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:21:02,662 unpacking tar archive at: fx-team-5f550071f889/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722737 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.636480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.636814) ========= script_repo_revision: 5f550071f889ff522db03e1e8e86e4cea11b4962 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.637258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.637600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:21:01.650363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-30 05:21:01.650694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:03 INFO - MultiFileLogger online at 20160630 05:21:03 in /builds/slave/test 05:21:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:21:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:03 INFO - {'append_to_log': False, 05:21:03 INFO - 'base_work_dir': '/builds/slave/test', 05:21:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:03 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:03 INFO - 'config_files': ('talos/linux_config.py',), 05:21:03 INFO - 'default_actions': ('clobber', 05:21:03 INFO - 'read-buildbot-config', 05:21:03 INFO - 'download-and-extract', 05:21:03 INFO - 'populate-webroot', 05:21:03 INFO - 'create-virtualenv', 05:21:03 INFO - 'install', 05:21:03 INFO - 'run-tests'), 05:21:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:03 INFO - 'download_minidump_stackwalk': True, 05:21:03 INFO - 'download_symbols': 'ondemand', 05:21:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:03 INFO - 'installer_path': 'installer.exe', 05:21:03 INFO - 'log_level': 'info', 05:21:03 INFO - 'log_name': 'talos', 05:21:03 INFO - 'log_to_console': True, 05:21:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:03 INFO - 'opt_config_files': (), 05:21:03 INFO - 'pip_index': False, 05:21:03 INFO - 'sps_profile': False, 05:21:03 INFO - 'sps_profile_interval': 0, 05:21:03 INFO - 'suite': 'dromaeojs-e10s', 05:21:03 INFO - 'system_bits': '32', 05:21:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:03 INFO - 'title': 'talos-linux64-ix-068', 05:21:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:03 INFO - 'use_talos_json': True, 05:21:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:03 INFO - 'work_dir': 'build'} 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running clobber step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: clobber 05:21:03 INFO - rmtree: /builds/slave/test/build 05:21:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:03 INFO - Running post-action listener: _resource_record_post_action 05:21:03 INFO - ##### 05:21:03 INFO - ##### Finished clobber step (success) 05:21:03 INFO - ##### 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running read-buildbot-config step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: read_buildbot_config 05:21:03 INFO - Using buildbot properties: 05:21:03 INFO - { 05:21:03 INFO - "project": "", 05:21:03 INFO - "product": "firefox", 05:21:03 INFO - "script_repo_revision": "production", 05:21:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:21:03 INFO - "repository": "", 05:21:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:21:03 INFO - "buildid": "20160630045127", 05:21:03 INFO - "pgo_build": "False", 05:21:03 INFO - "basedir": "/builds/slave/test", 05:21:03 INFO - "buildnumber": 1396, 05:21:03 INFO - "slavename": "talos-linux64-ix-068", 05:21:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:21:03 INFO - "platform": "ubuntu64_hw", 05:21:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:03 INFO - "branch": "fx-team", 05:21:03 INFO - "repo_path": "integration/fx-team", 05:21:03 INFO - "revision": "5f550071f889ff522db03e1e8e86e4cea11b4962", 05:21:03 INFO - "stage_platform": "linux64", 05:21:03 INFO - "builduid": "150ab89b60ae4c669abd09f5b250b7f5", 05:21:03 INFO - "slavebuilddir": "test" 05:21:03 INFO - } 05:21:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:21:03 INFO - Running post-action listener: _resource_record_post_action 05:21:03 INFO - ##### 05:21:03 INFO - ##### Finished read-buildbot-config step (success) 05:21:03 INFO - ##### 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running download-and-extract step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: download_and_extract 05:21:03 INFO - mkdir: /builds/slave/test/build/tests 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:21:09 INFO - Downloaded 1361 bytes. 05:21:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:09 INFO - Using the following test package requirements: 05:21:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'jsshell-linux-x86_64.zip'], 05:21:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:11 INFO - Downloaded 22701713 bytes. 05:21:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:13 INFO - Return code: 0 05:21:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:21 INFO - Downloaded 22701713 bytes. 05:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:22 INFO - Return code: 0 05:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:22 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:23 INFO - Downloaded 14405242 bytes. 05:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:21:23 INFO - Return code: 0 05:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:23 INFO - https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:25 INFO - Downloaded 56450949 bytes. 05:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:25 INFO - mkdir: /builds/slave/test/properties 05:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:25 INFO - Contents: 05:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - Running post-action listener: set_extra_try_arguments 05:21:26 INFO - ##### 05:21:26 INFO - ##### Finished download-and-extract step (success) 05:21:26 INFO - ##### 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running populate-webroot step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: populate_webroot 05:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:26 INFO - '--tppagecycles', 05:21:26 INFO - '7'], 05:21:26 INFO - 'tests': ['tsvgm']}}, 05:21:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['damp', 'tps']}, 05:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['damp', 'tps']}, 05:21:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['dromaeo_dom']}, 05:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['basic_compositor_video']}, 05:21:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:21:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['a11yr', 05:21:26 INFO - 'ts_paint', 05:21:26 INFO - 'tpaint', 05:21:26 INFO - 'sessionrestore', 05:21:26 INFO - 'sessionrestore_no_auto_restore', 05:21:26 INFO - 'tabpaint']}, 05:21:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tsvgx', 05:21:26 INFO - 'tsvgr_opacity', 05:21:26 INFO - 'tart', 05:21:26 INFO - 'tscrollx', 05:21:26 INFO - 'cart']}, 05:21:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:26 INFO - 'tsvgr_opacity', 05:21:26 INFO - 'tart', 05:21:26 INFO - 'tscrollx', 05:21:26 INFO - 'cart']}, 05:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s'], 05:21:26 INFO - 'tests': ['tp5o']}, 05:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'tests': ['tp5o']}, 05:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--disable-e10s', 05:21:26 INFO - '--xperf_path', 05:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:26 INFO - 'tests': ['tp5n']}, 05:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:26 INFO - 'talos_options': ['--xperf_path', 05:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:26 INFO - 'tests': ['tp5n']}}, 05:21:26 INFO - 'talos.zip': {'path': '', 05:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - ##### 05:21:26 INFO - ##### Finished populate-webroot step (success) 05:21:26 INFO - ##### 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running create-virtualenv step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: create_virtualenv 05:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:26 INFO - Using real prefix '/usr' 05:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:28 INFO - Installing pip.................done. 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21: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', 'pip>=1.5'] in /builds/slave/test/build 05:21: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 pip>=1.5 05:21:28 INFO - Using env: {'DISPLAY': ':0', 05:21:28 INFO - 'HOME': '/home/cltbld', 05:21:28 INFO - 'LANG': 'en_US.UTF-8', 05:21:28 INFO - 'LANGUAGE': 'en_US:en', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MAIL': '/var/mail/cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SHLVL': '1', 05:21:28 INFO - 'TERM': 'linux', 05:21:28 INFO - 'TMOUT': '86400', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - '_': '/tools/buildbot/bin/python'} 05:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21: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 05:21:28 INFO - Cleaning up... 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21: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 05:21: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 05:21:28 INFO - Using env: {'DISPLAY': ':0', 05:21:28 INFO - 'HOME': '/home/cltbld', 05:21:28 INFO - 'LANG': 'en_US.UTF-8', 05:21:28 INFO - 'LANGUAGE': 'en_US:en', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MAIL': '/var/mail/cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SHLVL': '1', 05:21:28 INFO - 'TERM': 'linux', 05:21:28 INFO - 'TMOUT': '86400', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - '_': '/tools/buildbot/bin/python'} 05:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:29 INFO - Downloading/unpacking psutil>=3.1.1 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:31 INFO - Installing collected packages: psutil 05:21:31 INFO - Running setup.py install for psutil 05:21:31 INFO - building 'psutil._psutil_linux' extension 05:21:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:21:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:21:31 INFO - building 'psutil._psutil_posix' extension 05:21:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:21:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:31 INFO - Successfully installed psutil 05:21:31 INFO - Cleaning up... 05:21:31 INFO - Return code: 0 05:21:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:31 INFO - Using env: {'DISPLAY': ':0', 05:21:31 INFO - 'HOME': '/home/cltbld', 05:21:31 INFO - 'LANG': 'en_US.UTF-8', 05:21:31 INFO - 'LANGUAGE': 'en_US:en', 05:21:31 INFO - 'LOGNAME': 'cltbld', 05:21:31 INFO - 'MAIL': '/var/mail/cltbld', 05:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:31 INFO - 'MOZ_NO_REMOTE': '1', 05:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:31 INFO - 'NO_EM_RESTART': '1', 05:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:31 INFO - 'PWD': '/builds/slave/test', 05:21:31 INFO - 'SHELL': '/bin/bash', 05:21:31 INFO - 'SHLVL': '1', 05:21:31 INFO - 'TERM': 'linux', 05:21:31 INFO - 'TMOUT': '86400', 05:21:31 INFO - 'USER': 'cltbld', 05:21:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:31 INFO - '_': '/tools/buildbot/bin/python'} 05:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:33 INFO - Installing collected packages: mozsystemmonitor 05:21:33 INFO - Running setup.py install for mozsystemmonitor 05:21:33 INFO - Successfully installed mozsystemmonitor 05:21:33 INFO - Cleaning up... 05:21:34 INFO - Return code: 0 05:21:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:21:34 INFO - Using env: {'DISPLAY': ':0', 05:21:34 INFO - 'HOME': '/home/cltbld', 05:21:34 INFO - 'LANG': 'en_US.UTF-8', 05:21:34 INFO - 'LANGUAGE': 'en_US:en', 05:21:34 INFO - 'LOGNAME': 'cltbld', 05:21:34 INFO - 'MAIL': '/var/mail/cltbld', 05:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:34 INFO - 'MOZ_NO_REMOTE': '1', 05:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:34 INFO - 'NO_EM_RESTART': '1', 05:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:34 INFO - 'PWD': '/builds/slave/test', 05:21:34 INFO - 'SHELL': '/bin/bash', 05:21:34 INFO - 'SHLVL': '1', 05:21:34 INFO - 'TERM': 'linux', 05:21:34 INFO - 'TMOUT': '86400', 05:21:34 INFO - 'USER': 'cltbld', 05:21:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:34 INFO - '_': '/tools/buildbot/bin/python'} 05:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:36 INFO - warning: no files found matching '*.txt' 05:21:36 INFO - no previously-included directories found matching 'build' 05:21:36 INFO - no previously-included directories found matching 'dist' 05:21:36 INFO - no previously-included directories found matching '.git*' 05:21:36 INFO - Installing collected packages: jsonschema, functools32 05:21:36 INFO - Running setup.py install for functools32 05:21:36 INFO - warning: no files found matching '*.txt' 05:21:36 INFO - no previously-included directories found matching 'build' 05:21:36 INFO - no previously-included directories found matching 'dist' 05:21:36 INFO - no previously-included directories found matching '.git*' 05:21:36 INFO - Successfully installed jsonschema functools32 05:21:36 INFO - Cleaning up... 05:21:36 INFO - Return code: 0 05:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:36 INFO - Using env: {'DISPLAY': ':0', 05:21:36 INFO - 'HOME': '/home/cltbld', 05:21:36 INFO - 'LANG': 'en_US.UTF-8', 05:21:36 INFO - 'LANGUAGE': 'en_US:en', 05:21:36 INFO - 'LOGNAME': 'cltbld', 05:21:36 INFO - 'MAIL': '/var/mail/cltbld', 05:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:36 INFO - 'MOZ_NO_REMOTE': '1', 05:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:36 INFO - 'NO_EM_RESTART': '1', 05:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:36 INFO - 'PWD': '/builds/slave/test', 05:21:36 INFO - 'SHELL': '/bin/bash', 05:21:36 INFO - 'SHLVL': '1', 05:21:36 INFO - 'TERM': 'linux', 05:21:36 INFO - 'TMOUT': '86400', 05:21:36 INFO - 'USER': 'cltbld', 05:21:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:36 INFO - '_': '/tools/buildbot/bin/python'} 05:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:39 INFO - Downloading docopt-0.6.1.tar.gz 05:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:39 INFO - Running setup.py install for blobuploader 05:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:39 INFO - Running setup.py install for requests 05:21:39 INFO - Running setup.py install for docopt 05:21:40 INFO - Successfully installed blobuploader requests docopt 05:21:40 INFO - Cleaning up... 05:21:40 INFO - Return code: 0 05:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:40 INFO - Using env: {'DISPLAY': ':0', 05:21:40 INFO - 'HOME': '/home/cltbld', 05:21:40 INFO - 'LANG': 'en_US.UTF-8', 05:21:40 INFO - 'LANGUAGE': 'en_US:en', 05:21:40 INFO - 'LOGNAME': 'cltbld', 05:21:40 INFO - 'MAIL': '/var/mail/cltbld', 05:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:40 INFO - 'MOZ_NO_REMOTE': '1', 05:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:40 INFO - 'NO_EM_RESTART': '1', 05:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:40 INFO - 'PWD': '/builds/slave/test', 05:21:40 INFO - 'SHELL': '/bin/bash', 05:21:40 INFO - 'SHLVL': '1', 05:21:40 INFO - 'TERM': 'linux', 05:21:40 INFO - 'TMOUT': '86400', 05:21:40 INFO - 'USER': 'cltbld', 05:21:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:40 INFO - '_': '/tools/buildbot/bin/python'} 05:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:40 INFO - Running setup.py (path:/tmp/pip-PENNIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:40 INFO - Running setup.py (path:/tmp/pip-RaM6l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:40 INFO - Running setup.py (path:/tmp/pip-XlvPHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:40 INFO - Running setup.py (path:/tmp/pip-dqvvQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:40 INFO - Running setup.py (path:/tmp/pip-7LGxGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:40 INFO - Running setup.py (path:/tmp/pip-iz4OrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:40 INFO - Running setup.py (path:/tmp/pip-7Jdjy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:40 INFO - Running setup.py (path:/tmp/pip-wy55bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:40 INFO - Running setup.py (path:/tmp/pip-LiZ9Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:40 INFO - Running setup.py (path:/tmp/pip-Kd6fRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:41 INFO - Running setup.py (path:/tmp/pip-3pb4w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:41 INFO - Running setup.py (path:/tmp/pip-9Td69y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:41 INFO - Running setup.py (path:/tmp/pip-2hrLEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:41 INFO - Running setup.py (path:/tmp/pip-W6XRtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:41 INFO - Running setup.py (path:/tmp/pip-a5Ns9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:41 INFO - Running setup.py (path:/tmp/pip-bZhEH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:41 INFO - Running setup.py (path:/tmp/pip-_UaNxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:41 INFO - Running setup.py install for manifestparser 05:21:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:41 INFO - Running setup.py install for mozcrash 05:21:41 INFO - Running setup.py install for mozdebug 05:21:41 INFO - Running setup.py install for mozdevice 05:21:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozfile 05:21:42 INFO - Running setup.py install for mozhttpd 05:21:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozinfo 05:21:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozInstall 05:21:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozleak 05:21:42 INFO - Running setup.py install for mozlog 05:21:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for moznetwork 05:21:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozprocess 05:21:42 INFO - Running setup.py install for mozprofile 05:21:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:42 INFO - Running setup.py install for mozrunner 05:21:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:43 INFO - Running setup.py install for mozscreenshot 05:21:43 INFO - Running setup.py install for moztest 05:21:43 INFO - Running setup.py install for mozversion 05:21:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:43 INFO - Cleaning up... 05:21:43 INFO - Return code: 0 05:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:43 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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:43 INFO - Using env: {'DISPLAY': ':0', 05:21:43 INFO - 'HOME': '/home/cltbld', 05:21:43 INFO - 'LANG': 'en_US.UTF-8', 05:21:43 INFO - 'LANGUAGE': 'en_US:en', 05:21:43 INFO - 'LOGNAME': 'cltbld', 05:21:43 INFO - 'MAIL': '/var/mail/cltbld', 05:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:43 INFO - 'MOZ_NO_REMOTE': '1', 05:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:43 INFO - 'NO_EM_RESTART': '1', 05:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:43 INFO - 'PWD': '/builds/slave/test', 05:21:43 INFO - 'SHELL': '/bin/bash', 05:21:43 INFO - 'SHLVL': '1', 05:21:43 INFO - 'TERM': 'linux', 05:21:43 INFO - 'TMOUT': '86400', 05:21:43 INFO - 'USER': 'cltbld', 05:21:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:43 INFO - '_': '/tools/buildbot/bin/python'} 05:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:43 INFO - Running setup.py (path:/tmp/pip-hQ883p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:43 INFO - Running setup.py (path:/tmp/pip-viEtKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:43 INFO - Running setup.py (path:/tmp/pip-0gNRmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:43 INFO - Running setup.py (path:/tmp/pip-TL__pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:43 INFO - Running setup.py (path:/tmp/pip-mAWQn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:43 INFO - Running setup.py (path:/tmp/pip-G3XrgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:44 INFO - Running setup.py (path:/tmp/pip-kM68P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:44 INFO - Running setup.py (path:/tmp/pip-zCkZDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:44 INFO - Running setup.py (path:/tmp/pip-Lg8gsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:44 INFO - Running setup.py (path:/tmp/pip-_C2aT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:44 INFO - Running setup.py (path:/tmp/pip-o5DjDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:44 INFO - Running setup.py (path:/tmp/pip-gA3Ebv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:44 INFO - Running setup.py (path:/tmp/pip-B6SnBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:44 INFO - Running setup.py (path:/tmp/pip-qJPNyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:44 INFO - Running setup.py (path:/tmp/pip-3tZsAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:44 INFO - Running setup.py (path:/tmp/pip-tXyjYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:44 INFO - Running setup.py (path:/tmp/pip-G_OCX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:46 INFO - Downloading blessings-1.6.tar.gz 05:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:46 INFO - Installing collected packages: blessings 05:21:46 INFO - Running setup.py install for blessings 05:21:46 INFO - Successfully installed blessings 05:21:46 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:47 INFO - Reading from file tmpfile_stdout 05:21:47 INFO - Current package versions: 05:21:47 INFO - argparse == 1.2.1 05:21:47 INFO - blessings == 1.6 05:21:47 INFO - blobuploader == 1.2.4 05:21:47 INFO - docopt == 0.6.1 05:21:47 INFO - functools32 == 3.2.3-2 05:21:47 INFO - jsonschema == 2.5.1 05:21:47 INFO - manifestparser == 1.1 05:21:47 INFO - mozInstall == 1.12 05:21:47 INFO - mozcrash == 0.17 05:21:47 INFO - mozdebug == 0.1 05:21:47 INFO - mozdevice == 0.48 05:21:47 INFO - mozfile == 1.2 05:21:47 INFO - mozhttpd == 0.7 05:21:47 INFO - mozinfo == 0.9 05:21:47 INFO - mozleak == 0.1 05:21:47 INFO - mozlog == 3.2 05:21:47 INFO - moznetwork == 0.27 05:21:47 INFO - mozprocess == 0.22 05:21:47 INFO - mozprofile == 0.28 05:21:47 INFO - mozrunner == 6.11 05:21:47 INFO - mozscreenshot == 0.1 05:21:47 INFO - mozsystemmonitor == 0.3 05:21:47 INFO - moztest == 0.7 05:21:47 INFO - mozversion == 1.4 05:21:47 INFO - psutil == 3.1.1 05:21:47 INFO - requests == 1.2.3 05:21:47 INFO - wsgiref == 0.1.2 05:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 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 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:47 INFO - Using env: {'DISPLAY': ':0', 05:21:47 INFO - 'HOME': '/home/cltbld', 05:21:47 INFO - 'LANG': 'en_US.UTF-8', 05:21:47 INFO - 'LANGUAGE': 'en_US:en', 05:21:47 INFO - 'LOGNAME': 'cltbld', 05:21:47 INFO - 'MAIL': '/var/mail/cltbld', 05:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:47 INFO - 'MOZ_NO_REMOTE': '1', 05:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:47 INFO - 'NO_EM_RESTART': '1', 05:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:47 INFO - 'PWD': '/builds/slave/test', 05:21:47 INFO - 'SHELL': '/bin/bash', 05:21:47 INFO - 'SHLVL': '1', 05:21:47 INFO - 'TERM': 'linux', 05:21:47 INFO - 'TMOUT': '86400', 05:21:47 INFO - 'USER': 'cltbld', 05:21:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:47 INFO - '_': '/tools/buildbot/bin/python'} 05:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:47 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2181030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:47 INFO - Using env: {'DISPLAY': ':0', 05:21:47 INFO - 'HOME': '/home/cltbld', 05:21:47 INFO - 'LANG': 'en_US.UTF-8', 05:21:47 INFO - 'LANGUAGE': 'en_US:en', 05:21:47 INFO - 'LOGNAME': 'cltbld', 05:21:47 INFO - 'MAIL': '/var/mail/cltbld', 05:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:47 INFO - 'MOZ_NO_REMOTE': '1', 05:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:47 INFO - 'NO_EM_RESTART': '1', 05:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:47 INFO - 'PWD': '/builds/slave/test', 05:21:47 INFO - 'SHELL': '/bin/bash', 05:21:47 INFO - 'SHLVL': '1', 05:21:47 INFO - 'TERM': 'linux', 05:21:47 INFO - 'TMOUT': '86400', 05:21:47 INFO - 'USER': 'cltbld', 05:21:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:47 INFO - '_': '/tools/buildbot/bin/python'} 05:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:47 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Running post-action listener: _resource_record_post_action 05:21:47 INFO - Running post-action listener: _start_resource_monitoring 05:21:47 INFO - Starting resource monitoring. 05:21:47 INFO - ##### 05:21:47 INFO - ##### Finished create-virtualenv step (success) 05:21:47 INFO - ##### 05:21:47 INFO - ##### 05:21:47 INFO - ##### Running install step. 05:21:47 INFO - ##### 05:21:47 INFO - Running pre-action listener: _resource_record_pre_action 05:21:47 INFO - Running main action method: install 05:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:47 INFO - Reading from file tmpfile_stdout 05:21:47 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:47 INFO - Reading from file tmpfile_stdout 05:21:47 INFO - Output received: 05:21:47 INFO - Usage: mozinstall [options] installer 05:21:47 INFO - Options: 05:21:47 INFO - -h, --help show this help message and exit 05:21:47 INFO - -d DEST, --destination=DEST 05:21:47 INFO - Directory to install application into. [default: 05:21:47 INFO - "/builds/slave/test"] 05:21:47 INFO - --app=APP Application being installed. [default: firefox] 05:21:47 INFO - mkdir: /builds/slave/test/build/application 05:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:22:04 INFO - Reading from file tmpfile_stdout 05:22:04 INFO - Output received: 05:22:04 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:04 INFO - Running post-action listener: _resource_record_post_action 05:22:04 INFO - ##### 05:22:04 INFO - ##### Finished install step (success) 05:22:04 INFO - ##### 05:22:04 INFO - ##### 05:22:04 INFO - ##### Running run-tests step. 05:22:04 INFO - ##### 05:22:04 INFO - Running pre-action listener: _resource_record_pre_action 05:22:04 INFO - Running main action method: run_tests 05:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:04 INFO - Python 2.7.3 05:22:04 INFO - Return code: 0 05:22:04 INFO - grabbing minidump binary from tooltool 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:04 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 0x243f570>, '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 0x2440470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2440900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:22:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:22:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:04 INFO - Return code: 0 05:22:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 05:22:04 INFO - Using env: {'DISPLAY': ':0', 05:22:04 INFO - 'HOME': '/home/cltbld', 05:22:04 INFO - 'LANG': 'en_US.UTF-8', 05:22:04 INFO - 'LANGUAGE': 'en_US:en', 05:22:04 INFO - 'LOGNAME': 'cltbld', 05:22:04 INFO - 'MAIL': '/var/mail/cltbld', 05:22:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:04 INFO - 'MOZ_NO_REMOTE': '1', 05:22:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:04 INFO - 'NO_EM_RESTART': '1', 05:22:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:04 INFO - 'PWD': '/builds/slave/test', 05:22:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:04 INFO - 'SHELL': '/bin/bash', 05:22:04 INFO - 'SHLVL': '1', 05:22:04 INFO - 'TERM': 'linux', 05:22:04 INFO - 'TMOUT': '86400', 05:22:04 INFO - 'USER': 'cltbld', 05:22:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670', 05:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:04 INFO - '_': '/tools/buildbot/bin/python'} 05:22:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:22:04 INFO - mozversion application_buildid: 20160630045127 05:22:04 INFO - mozversion application_changeset: 5f550071f889ff522db03e1e8e86e4cea11b4962 05:22:04 INFO - mozversion application_display_name: Nightly 05:22:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:04 INFO - mozversion application_name: Firefox 05:22:04 INFO - mozversion application_remotingname: firefox 05:22:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:04 INFO - mozversion application_vendor: Mozilla 05:22:04 INFO - mozversion application_version: 50.0a1 05:22:04 INFO - mozversion platform_buildid: 20160630045127 05:22:04 INFO - mozversion platform_changeset: 5f550071f889ff522db03e1e8e86e4cea11b4962 05:22:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:04 INFO - mozversion platform_version: 50.0a1 05:22:04 INFO - using testdate: 1467289324 05:22:04 INFO - actual date: 1467289324 05:22:04 INFO - starting webserver on 'localhost:35159' 05:22:04 INFO - SUITE-START | Running 2 tests 05:22:04 INFO - TEST-START | dromaeo_css 05:22:04 INFO - operating with platform_type : linux_ 05:22:04 INFO - Initialising browser for dromaeo_css test... 05:22:04 INFO - TEST-INFO | started process 30341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBfYJ7/profile http://localhost:35159/getInfo.html) 05:22:09 INFO - PROCESS | 30341 | __metrics Screen width/height:1600/1200 05:22:09 INFO - PROCESS | 30341 | colorDepth:24 05:22:09 INFO - PROCESS | 30341 | Browser inner width/height: 1024/697 05:22:09 INFO - PROCESS | 30341 | __metrics 05:22:10 ERROR - PROCESS | 30341 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:22:11 INFO - TEST-INFO | 30341: exit 0 05:22:11 INFO - Browser initialized. 05:22:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:11 INFO - TEST-INFO | started process 30461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBfYJ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:22 INFO - PROCESS | 30461 | RSS: Main: 169717760 05:22:22 INFO - PROCESS | 30461 | 05:23:12 INFO - PROCESS | 30461 | 1467289392579 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:24 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35159/tests/dromaeo/cssquery-ext.html) 05:25:25 INFO - PROCESS | 30461 | RSS: Main: 169553920 05:25:25 INFO - PROCESS | 30461 | 05:28:27 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-ext.html (next: http://localhost:35159/tests/dromaeo/cssquery-jquery.html) 05:28:28 INFO - PROCESS | 30461 | RSS: Main: 169086976 05:28:28 INFO - PROCESS | 30461 | 05:31:30 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35159/tests/dromaeo/cssquery-mootools.html) 05:31:31 INFO - PROCESS | 30461 | RSS: Main: 172388352 05:31:31 INFO - PROCESS | 30461 | 05:34:33 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35159/tests/dromaeo/cssquery-prototype.html) 05:34:33 INFO - PROCESS | 30461 | RSS: Main: 167858176 05:34:33 INFO - PROCESS | 30461 | 05:37:36 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35159/tests/dromaeo/cssquery-yui.html) 05:37:37 INFO - PROCESS | 30461 | RSS: Main: 170094592 05:37:37 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | Cycle 1(1): loaded http://localhost:35159/tests/dromaeo/cssquery-yui.html (next: http://localhost:35159/tests/dromaeo/cssquery-dojo.html) 05:40:39 INFO - PROCESS | 30461 | RSS: Main: 171188224 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | __start_tp_report 05:40:39 INFO - PROCESS | 30461 | _x_x_mozilla_page_load 05:40:39 INFO - PROCESS | 30461 | _x_x_mozilla_page_load_details 05:40:39 INFO - PROCESS | 30461 | |i|pagename|runs| 05:40:39 INFO - PROCESS | 30461 | |0;dojo.html;2634.6443230163927;2675.7993150513717;2678.611601317809;2711.3628297350133;2717.538018536847;4839.370881785372;4880.755962201889;4909.386326709161;4930.137225985452;4960.1319769040365;4714.811407543702;4902.975485122578;4917.409910810698;4930.506949305068;4977.626677999156;4444.599986001259;4491.281394976788;4606.032733126048;4609.193391156534;4619.422572178478;523.7884709836052;4425.77871106445;4502.482214545336;4560.863174104766;4600.953990460086;4473.888152796174;4475.1049790042125;4478.664100192483;4499.460064792213;4538.887972446739;4391.934120988188;4482.327650852366;4497.617702495292;4507.797149128264;4515.480719717241;4362.236608593484;4393.6045755881805;4411.316245981878;4412.426384570017;4458.665600080007;4767.165745994472;4835.419749630032;4843.22508398658;4867.342908707315;4890.437599676012;5114.360704911886;5179.974100129475;5183.792648294101;5274.630775845692;5316.4683531646915;5208.322918020633;5246.396664383607;5310.44240354761;5315.867103322409;5357.517823395874;4817.807287708488;4914.4839791821705;4933.629977751683;4936.6050715943;4939.110960027229;5166.689998600096;5277.788888444419;5322.787088516493;5354.732263386815;5405.054115529767;5146.845594632092;5150.768215430315;5152.201408781645;5153.742312884341;5156.226566015128;5191.740412979336;5215.16557350822;5229.764660590283;5241.73791310433;5302.443243459458;5055.469175736494;5141.820036298786;5144.485551444825;5165.845024649267;5187.0922588546855;5043.924341134886;5127.333446651912;5134.460881607452;5137.845864624067;5138.563222126161;4434.445694288214;4452.376667266585;4467.262901621196;4470.173017991617;4495.617872480876;3763.9623603764157;3790.6209379062425;3837.213371258885;3839.3665045267776;3918.7452815567467;4501.954980450154;4516.638668906479;4522.412086428809;4537.0925814837165;4580.427446569179;5270.762815673227;5298.470152984671;5308.522232999048;5319.973400133052;5327.200919862052;4382.780860956939;4439.66702497314;4477.664175186874;4504.909901801946;4562.110388474282;4676.7661616919695;4696.178168820443;4747.501512341223;4790.449098353664;4818.084563932912;4899.755012249373;4908.533689299654;4915.852524424273;4925.5074492551175;4962;5054.519820617035;5202.193659982709;5250.973745131403;5265.921011184759;5295.973520132375;4917.188663870421;4931.3096166536;4937.358143441474;4958.404991401055;4994.825181118644;5217.295665085165;5217.921731174111;5235.554977826928;5237.2667826505085;5241.947580524146;5119.0529751996;5251.291075704731;5289;5305.628605997543;5326.4407237241085;5148.253503242084;5154.871128221825;5165.535101840853;5168.870778230424;5198.6880787152895;5017;5143.382794064736;5144.6913185209005;5173.40505841833;5177.456367081402;4824.541668541483;4884.877878053077;4945.530174633404;4949.727764972817;4967.975160124176;5096;5100.336956195819;5101.20931255656;5103.132467480612;5103.948960510347;4991.47589503097;5004.424491183415;5006.724630145377;5026.723530205873;5082.771275292546 05:40:39 INFO - PROCESS | 30461 | |1;ext.html;518.9025571265771;561.0882316236116;589.5489950188105;602.2652364115778;627.811656503049;35467.2906541869;39259.607403925955;39465.4080188797;39497.60502394975;39826;39283;39876.40185397222;39882.60117398825;39902.8004859976;39926.600733992724;7902.920970790276;8007.599620019005;8014.599270036504;8025.839483210332;8044.959775201116;7894.921050789505;7971.521708697468;7973.840523189533;7988.920110798876;7995.720149794758;7961.36309095271;7989.480683755566;7991.840163196762;8041.798955026142;8042.356611471068;7924.762257132295;7981.6009199540085;7989.800254993643;7999.0801057877925;8001.079875814297;7867.252611002003;7903.565303908283;7906.6837326506875;7949.6025198739835;7977.56123413212;38482.80758596189;39070.804645976874;39116.60883391158;39124.021899452455;39282.41076383857;3168.207948012997;3229.5640088587975;3340.615829179651;3352.9832350838333;3393.8472768725464;29640.40719185626;30064.24839379033;30480.390392192254;30902;31817.52273715896;3394.8472318745717;3422.709069729076;3454.7408944329277;3459.60214575322;3512.227309991798;255593;256671;257000.7149964257;257465;258918;31661.99211074944;52871;52939.470605293456;53139.46860531423;53344.73327633415;32558.83720581382;34139.31721365608;34327;34327.141821454665;34544;12590.43343049565;12689.619311420673;12696.301703406216;12750.617481475385;12849.550265740841;10392.168626509861;10459.790804183875;10563.683089507327;10581.57673693059;10612.09797167234;7952.324052455606;7989.121196668362;8011.278984891388;8081.232282933112;8106.797330066795;3120.8283544405276;3184.8726050958167;3196.888108916177;3215.887443939451;3234.369297986917;898.2589363774912;982.9164521015794;991.3358050106445;998.4109375468508;1010.2524132142308;29230.415391692473;29331.266718332212;29360.853195733886;29666.55500167499;29913.85043074771;930.497531333086;984.1782111936614;1021.5505177721778;1022.223110436074;1047.6856942917095;15180.848191518164;15375.692486150214;15419.61450963735;15487.225638718019;15559.688806223812;423178;423699;428487;428950;431524;50630.74684626627;50885.23672144921;51115.74442127765;51177;51248.48751512437;1189.8238747553817;1213.4721396192685;1232.648695121904;1235.9505619775289;1240.5968060380412;27133.1860044199;28549.714502855535;28644;28777.712222877504;28925.276868078465;43197.352039720055;43433.78283108564;43480.34779478247;43622.345664815686;43688.12623747444;339529;339794;342034;343173;344424;25204.495910082063;25536.23391298264;26271;26411.471770564865;27545.586816197374;42245.577544224165;42384;43510;44066.779666101465;44197.779011104736;36883.63116368802;37161.62838371582;37461.81269093637;37846.24307513779;38602.42096368501;36811.3434895425;37526;37590.43614345841;37699.43450848185;37724.24551509009;31526;36384.454233187054;36872;37201.25597488089;37748;31714.682853171173;34259.14352141217;34454.136954671776;34479.4828077574;34649.82675086709;26116.98618635449;26241.475170496866;26430.471390572464;26818.329541761614;26819.731802681723 05:40:39 INFO - PROCESS | 30461 | |2;jquery.html;370.7312198655974;371.1278495535492;373.9027852758283;387.7421514692729;389.08370786797093;15959.441419550318;17074.91462542687;17297.913510432445;17905.283788648438;17978.910105449486;13312.866871331284;13596;14381.78427323591;14392.424303027892;15038.774418383706;4529.433820772403;4815.3258543803895;4870.683405578626;4872.8050877965015;4874.951250487503;3425.45192769157;4722.05558888222;5060.848174554751;5310.867228319304;5347.0909945309195;5388;5389.51494365507;5397.568194544427;5403.054465468547;5422.9728851355685;5067.442581316052;5380.838574842761;5395.10980688186;5404.648697834628;5459.918101228484;5189.3772747270195;5216.321878155815;5256;5279.736013199363;5303.549198318109;20302.492437689027;20524.79475205244;21131.78868211329;21288;21438.57122857534;1772.7340898865145;1898.9240430382906;1940.553672655297;2173.989095070784;2208.5803697297624;9380.296477764196;9493.05069493052;9586.712398628053;9817.165540929029;13597;1727.5422013166522;1734.4276388791668;1752.3165965273554;1759.225940586138;1782.1801971093312;64468;71127.64436177838;71520;72188;72615;9999.700008999596;10058.245631577662;10082.848757268646;10188.847167292497;10463.215258855616;13997.3701183447;14129.85870141306;14133.081349712442;14186.929065354607;14216.360263788154;7229.349358557755;7262.31008054234;7274.236205198484;7424.294692004359;7437.479376443597;6807.863842723217;6837.760678376332;6922.930770692329;7035.296470353026;7044.471664625174;4318.913621727548;4352.891177720519;4353.651707863363;4363.629091527256;4428.73427594339;1653.5204790610828;1698.558374822555;1820.2355010895456;1851.1484717030316;1926.1428664244556;811.3549727966281;856.1908995998846;885.1900511032334;894.2264940826138;953.1802649721234;17255.74116388255;17297;17353.56616084608;17633.911830440764;17851;876.6230520876085;913.1872633356318;916.9954150229206;925.8055808280202;947.1570302430843;9671.17794987434;9673.758156046155;9773.41359518431;9872.160866326443;9892.455914924749;367939;368091;378289;388123;389178;80411;80437.59781201057;82958.43728594865;83283;83872;869.5130726793017;879.7668617816283;886.4592598514901;894.789724414762;903.3089686389917;15016.399344026117;15519.767203492183;15770.68458630798;15826.36694532252;16008.19959002022;36579;37009.25981480409;37382.25235495329;37483.625163748016;38185.80907095447;49805.25292120549;52026.47973520216;52321.7383913078;52692.736536317076;53008.46991530035;7558.168601453725;7573.431992600687;7574.886376704244;7691.115676659254;7833.764987050397;8763.649454021768;10862.674119776419;11397.316161030032;11858.229215100991;12026.518939242333;9885.512114646885;10001.849972250277;10396.428196449267;10592.788144237225;10784.838227426751;10011.899881001096;10035.34770239932;10295.330803497749;10325.432101234504;10336.948315258376;10008.44953527563;10280.331778434676;10345.601324364667;10473.895261047597;10633.521491532745;7098.72222999865;7202.171750248788;7672.7314543992925;7695.076590809139;7802.024746906637;9775.657851975147;9869.851952220866;10114;10149.441780702133;10307 05:40:39 INFO - PROCESS | 30461 | |3;mootools.html;1377.2218696436512;1401.6776141487458;1497.460914070935;1697.6519813438247;1729.8010728766187;7009.964950175255;7495.437842161832;7780.1052878918945;8333.624986875597;8338.833223335538;7698.34564062054;7719.884201736979;7905.644246008929;7959.801004974878;8005.719799807008;2156.0621129808505;2206.8455208135438;2208.436848603612;2209.9116035358566;2222.5221577360862;2153.493928926701;2177.6080305544997;2213.9225127120553;2215.191455118878;2216.556688662266;2181.8472706910525;2196.3081629286726;2200.284907405092;2200.9889950550305;2229.9331020069344;2133.669281261407;2134.871907685536;2138.7219661443914;2142.2073832681854;2148.9140434382607;2114.2811444108925;2139.443744626393;2141;2152.8923553822247;2153.967690484644;7765.611719414063;7858.292753652198;7864.842703145962;7870.331021863149;7885.211478852127;4384.079343337903;4474.0604473060375;4482.462104547442;4522.4573051234065;4531.184386810372;2845.445138198052;2870.3111253299267;2938.6620538637903;2942.823430594171;2950.822950622948;910.7540963939699;949.6343907595557;953.0707560128889;954.5799848066829;965.9664159349499;10628.627998020032;10843.783124337548;10875.673729788119;10912.672619821418;10922.508487118099;4102.425660407545;4194.328907374806;4248.596383343577;4328.523862375137;4354.716943398669;9397.919239287432;9437.480938548308;9451.385659932082;9462.858057129148;9469.66856160031;4557.202489564313;4564.657650676212;4586.220342541709;4588.747618880993;4602.7008244464005;3657.2685462907525;3980.3432433648704;4101.425800387948;4118.155778065489;4146.647534959562;3722.4974628424816;3737.1404576947452;3816.923661526754;3824.827882745283;3872.3223435898603;1160.1356989043047;1227.061298106949;1228.9446974886152;1233.8334324866207;1233.9814902776466;724.4277021153335;789.973035054427;838.2748922182391;839.3075712537059;849.1762989899787;4987.301777751118;5159.974200128975;5167.224916262516;5193.818216362409;5260.263563101169;874.6938571500051;898.7842917699705;900.4372267332917;902.8826252587122;905.6151135767273;3617.4935509028755;3619.2218672985437;3681.668649821529;3726.1988672435014;3762.191128907243;9782.804343913223;10037.64868229623;10079.69760907174;10117.747056323504;10292.125169360539;9966.152877005536;9971.900280997243;9978.201743860474;10013.048760367754;10024.649137280161;7403.444741644398;7455.776326710207;7568.886466703004;7577.924220757832;7638.618069096523;5042.798288068583;5064.873378165576;5086.898262034812;5089.185730283285;5539.612227144223;8793.736187914374;8883.200511953955;9021.503817290111;9212.216961558343;9327.533623318672;9372.109649583279;9445;9463.432194068379;9640.373375730554;9647.1317581418;6766;7091.574505529685;7308.524945878501;7507.136679281953;7759.72840950564;7702.691892324468;7773.3004029637605;7773.883391749016;7775.572343520935;7840.647170877211;6948.270431604608;7085;7176.748813791701;7178.4257259420165;7191.2449192834;6999.230084690578;7000.47496437759;7017.614031228127;7096.396806271318;7123.536970096927;5791.276090488689;5905.379935106924;5975.701214939322;5987.461128498456;6083.391660834058;4502;4508.571685689854;4542.545745425563;4548.863534093983;4552.5447455255535;4429.069895322018;4533.478649955297;4552.021315417202;4587.151376995266;4597.333386658983 05:40:39 INFO - PROCESS | 30461 | |4;prototype.html;279.90063527447745;285.4505077725379;293.29316347602276;294.80395536967916;298.926762943079;4924.482929292418;5035.219540971146;5075.39095308563;5123.410807757109;5142.202958541423;5054.570361519266;5059.241113832927;5078.085944529983;5078.568321692661;5082.720450375228;3945.171513982067;3971;3991.6407523322896;3992.6007399260134;4008.719389642726;3928;3978.9403158952496;4014.1770936957855;4017.7388469749517;4026.4966879140106;3962.5046869141356;3963.4847469828883;3969.412235105952;3975.2248311579256;3976.9204615907665;3981.2634662587516;3986.6013398660193;3993.8801835944823;4017.738846974937;4020.4170395292813;3553.076200187944;3555;3561.8753343632848;3574.7140228781896;3584.480250363709;4893.363862697862;4974.850754477336;4983.377077865267;5010;5075.670081444731;4561.133384656904;4570.611498022672;4584.426946631671;4593.5406459354135;4603.631709463235;5342.385625653061;5346.492083252085;5347.598930080259;5376.569874410038;5393.164059570773;3761.9090463765474;3768.9623103768886;3788.5264341957254;3807.276617442677;3839.4432807243074;5575.553955683536;5582.078956972095;5587.608867379285;5616.691081990489;5627.746751396197;3912.8065939888606;3924.4898163238595;3937.5078115235597;3941.684665226775;3965.1871366369824;3885.339492286318;4005.239004589177;4021.3565829467143;4026.5369482509886;4032.395140728914;4526.388937493396;4555.658325625525;4559.452865656142;4564.817407303671;4565.5206203348835;5345.679259244458;5376.736466930268;5390.380106287827;5397.46172340881;5406;1275.2858399296424;1307.875751803577;1345.9636080218177;1350.743358761832;1362.5639795265618;921.4655499810094;924.2190349154953;937.0816599732165;942.1097063275276;950.7860731335394;4502.212112880233;4603.562661547147;4605.700629459075;4606.378138951266;4613.63090952723;5466.234727138204;5488.53347465462;5491.945080549143;5493.862653433616;5509.614326997072;4530.252508336088;4650.6046986005895;4652.97673511637;4664.906701865943;4693.296005599187;2979.5381715834083;2981.4484320400798;3004.5643381709965;3005.8046226995175;3011.7741169412384;5183.948160518422;5226.216067589892;5263.842084737464;5268.947310526845;5270.209468579744;5422.620416570802;5715.5427565794635;5724.971375143181;5731.876127510517;5734.254546908875;5229.241759944863;5244.868878278074;5247.772619838772;5254.474552544715;5271.235670827785;5603.439656034364;5606.85982850432;5611.943880561143;5644.774209031592;5657.4908258256955;5238.476152384731;5499.615026948075;5499.642523235977;5514.255575497256;5523.8895222096135;5217.165253559412;5223.92164117531;5238.738063096754;5253.658512196695;5267.57859371257;3810.9237815244096;3877.224555088937;3905.5785413044096;3906.902327441837;3924.293627147141;5265.868353291198;5335.35975682905;5466.289382380265;5595.468430499096;5602.691851948182;5365.463453654604;5387.299651045339;5393.9730301348245;5398.811041613525;5422.48486393792;5305.893882122413;5368.208531563643;5370.2213179089595;5375.919361209507;5411.242426060276;5194.97402512985;5243.711595862112;5265.552428043659;5275.762590683352;5276.973615131899;5394.9460505394445;5404.216388623706;5417.891642167056;5419.918701219406;5433.701146436826;5321.281626980308;5333.226682131147;5337.332833395825;5359.946400535945;5391.9460805391445 05:40:39 INFO - PROCESS | 30461 | |5;yui.html;621.4158690830619;658.9176352955883;682.1643486728755;707.0666719929692;740.1931894235285;12881;13458.596242112728;13510.93244533776;13855.168689878601;13869;12853.100282980171;12883.033772467055;12932.353382330894;12984.220946743179;12991.935040324808;642.0401499757869;772.4013889235831;775.3835700618022;811.3306522119245;811.4968719393984;799.4963173200904;804.1556365815899;807.3097501636105;810.7932477218301;812.0904586862722;843.3674743942044;846.4413487098516;850.4684572142411;850.7277671145235;851.1658574596898;837.7612380471536;838.3460900497622;839.4040231435688;842.8314337132598;843.304273973974;614.0420943328422;617.478230894893;617.555360140698;617.604732970899;618.4186864347544;12978.675533111653;13046.608601741867;13076.673083172902;13082.411291491811;13125.803112953314;12979.610611681665;13050.412731427108;13059.347032648424;13073.738525229443;13288.3355832208;10460.895391046068;10480.528376223088;10524.36853788775;10546.841797373045;10716.142708583373;3167;3216.469282568397;3216.758743094277;3218.6942240487115;3252.5446437498767;58830.70584647092;59806.70096649532;60103.398966010216;60440.69779651117;60528.39471605272;10456.163506919429;10494.370337779605;10523.315984460985;10667.14662826972;10821.404822734825;20260.392188234375;20507.69238461424;20508.79491205069;20555.177792888415;20571.485712857;6477.514186436036;6623.9006414903815;6650.20197576294;6665.200175978914;6868.553544019623;3593.8023408712247;3676.5036720042986;3737.5141231640255;3764.247150569897;3815.37046387343;2825.166575860126;2914.0529327968493;2928.8828446862312;2935.383569450439;2940.0738767288235;498.464151037636;518.1709265175689;518.6214063733496;523.5575938332104;525.6005435868691;552.1303946284618;555.4972749661563;583.0525396231125;587.7355190164443;591.6479694581717;7405;7419.591922444318;7485.5508669480005;7488.513246638951;7601.505902116345;550.1829782772579;571.865611581278;579.0445764488543;583.804425517448;602.4668168670757;3703.79629120401;3747.4940882980995;3794.905127371783;3851.78815165163;3906.121122747416;52474.21288680673;84690;87293;92968.53515732514;93574;80799.59600202079;82669;84045.15954840374;84291;85873.57063214644;70967.6451617749;71162.28837711661;71825.53570178708;72361;72493;6890.621015844176;7057.470689698191;7277.417806575567;7322.121345438582;7580.090389153337;30406.695933040388;36527.634723653486;38182.23635527218;39073.41389879211;45304;39533.604663952996;40525.79737101296;43198.78400607977;49344.013119736686;61237;11527.546532143566;11611.187216894736;11721.706957326134;11733.237339573241;11874.52501899949;12907.354632268161;13216.405261763051;13241.205527668371;13391.196528208338;13408.463661453432;11316.292367490423;11381.54473821038;11401.828972565583;11457.59898403552;11508.079353651856;11556.186101424104;11857.525698971944;11859.229150105215;12053.63839084829;12259.693507662023;11032.227744057838;11172.273802202832;11368.431578420881;11565.248258863146;12099.395030248628;9547.474888881177;9802.16681582045;9884.703458896245;10130.493475326057;10250.641227557;9944.850827237742;10051.49742512886;10229;10295.794084118426;10370.896291036994 05:40:39 INFO - PROCESS | 30461 | __end_tp_report 05:40:39 INFO - PROCESS | 30461 | __start_cc_report 05:40:39 INFO - PROCESS | 30461 | _x_x_mozilla_cycle_collect,375 05:40:39 INFO - PROCESS | 30461 | __end_cc_report 05:40:39 INFO - PROCESS | 30461 | __startTimestamp1467290439889__endTimestamp 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | ------- Summary: start ------- 05:40:39 INFO - PROCESS | 30461 | Number of tests: 6 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#0] dojo.html Cycles:165 Average:4805.79 Median:4949.73 stddev:614.96 (12.4%) stddev-sans-first:592.79 05:40:39 INFO - PROCESS | 30461 | Values: 2634.6 2675.8 2678.6 2711.4 2717.5 4839.4 4880.8 4909.4 4930.1 4960.1 4714.8 4903.0 4917.4 4930.5 4977.6 4444.6 4491.3 4606.0 4609.2 4619.4 523.8 4425.8 4502.5 4560.9 4601.0 4473.9 4475.1 4478.7 4499.5 4538.9 4391.9 4482.3 4497.6 4507.8 4515.5 4362.2 4393.6 4411.3 4412.4 4458.7 4767.2 4835.4 4843.2 4867.3 4890.4 5114.4 5180.0 5183.8 5274.6 5316.5 5208.3 5246.4 5310.4 5315.9 5357.5 4817.8 4914.5 4933.6 4936.6 4939.1 5166.7 5277.8 5322.8 5354.7 5405.1 5146.8 5150.8 5152.2 5153.7 5156.2 5191.7 5215.2 5229.8 5241.7 5302.4 5055.5 5141.8 5144.5 5165.8 5187.1 5043.9 5127.3 5134.5 5137.8 5138.6 4434.4 4452.4 4467.3 4470.2 4495.6 3764.0 3790.6 3837.2 3839.4 3918.7 4502.0 4516.6 4522.4 4537.1 4580.4 5270.8 5298.5 5308.5 5320.0 5327.2 4382.8 4439.7 4477.7 4504.9 4562.1 4676.8 4696.2 4747.5 4790.4 4818.1 4899.8 4908.5 4915.9 4925.5 4962.0 5054.5 5202.2 5251.0 5265.9 5296.0 4917.2 4931.3 4937.4 4958.4 4994.8 5217.3 5217.9 5235.6 5237.3 5241.9 5119.1 5251.3 5289.0 5305.6 5326.4 5148.3 5154.9 5165.5 5168.9 5198.7 5017.0 5143.4 5144.7 5173.4 5177.5 4824.5 4884.9 4945.5 4949.7 4968.0 5096.0 5100.3 5101.2 5103.1 5103.9 4991.5 5004.4 5006.7 5026.7 5082.8 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#1] ext.html Cycles:180 Average:48624.16 Median:37022.63 stddev:92314.50 (249.3%) stddev-sans-first:92502.81 05:40:39 INFO - PROCESS | 30461 | Values: 518.9 561.1 589.5 602.3 627.8 35467.3 39259.6 39465.4 39497.6 39826.0 39283.0 39876.4 39882.6 39902.8 39926.6 7902.9 8007.6 8014.6 8025.8 8045.0 7894.9 7971.5 7973.8 7988.9 7995.7 7961.4 7989.5 7991.8 8041.8 8042.4 7924.8 7981.6 7989.8 7999.1 8001.1 7867.3 7903.6 7906.7 7949.6 7977.6 38482.8 39070.8 39116.6 39124.0 39282.4 3168.2 3229.6 3340.6 3353.0 3393.8 29640.4 30064.2 30480.4 30902.0 31817.5 3394.8 3422.7 3454.7 3459.6 3512.2 255593.0 256671.0 257000.7 257465.0 258918.0 31662.0 52871.0 52939.5 53139.5 53344.7 32558.8 34139.3 34327.0 34327.1 34544.0 12590.4 12689.6 12696.3 12750.6 12849.6 10392.2 10459.8 10563.7 10581.6 10612.1 7952.3 7989.1 8011.3 8081.2 8106.8 3120.8 3184.9 3196.9 3215.9 3234.4 898.3 982.9 991.3 998.4 1010.3 29230.4 29331.3 29360.9 29666.6 29913.9 930.5 984.2 1021.6 1022.2 1047.7 15180.8 15375.7 15419.6 15487.2 15559.7 423178.0 423699.0 428487.0 428950.0 431524.0 50630.7 50885.2 51115.7 51177.0 51248.5 1189.8 1213.5 1232.6 1236.0 1240.6 27133.2 28549.7 28644.0 28777.7 28925.3 43197.4 43433.8 43480.3 43622.3 43688.1 339529.0 339794.0 342034.0 343173.0 344424.0 25204.5 25536.2 26271.0 26411.5 27545.6 42245.6 42384.0 43510.0 44066.8 44197.8 36883.6 37161.6 37461.8 37846.2 38602.4 36811.3 37526.0 37590.4 37699.4 37724.2 31526.0 36384.5 36872.0 37201.3 37748.0 31714.7 34259.1 34454.1 34479.5 34649.8 26117.0 26241.5 26430.5 26818.3 26819.7 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#2] jquery.html Cycles:180 Average:24163.80 Median:4396.18 stddev:62741.67 (1427.2%) stddev-sans-first:62892.24 05:40:39 INFO - PROCESS | 30461 | Values: 370.7 371.1 373.9 387.7 389.1 15959.4 17074.9 17297.9 17905.3 17978.9 13312.9 13596.0 14381.8 14392.4 15038.8 4529.4 4815.3 4870.7 4872.8 4875.0 3425.5 4722.1 5060.8 5310.9 5347.1 5388.0 5389.5 5397.6 5403.1 5423.0 5067.4 5380.8 5395.1 5404.6 5459.9 5189.4 5216.3 5256.0 5279.7 5303.5 20302.5 20524.8 21131.8 21288.0 21438.6 1772.7 1898.9 1940.6 2174.0 2208.6 9380.3 9493.1 9586.7 9817.2 13597.0 1727.5 1734.4 1752.3 1759.2 1782.2 64468.0 71127.6 71520.0 72188.0 72615.0 9999.7 10058.2 10082.8 10188.8 10463.2 13997.4 14129.9 14133.1 14186.9 14216.4 7229.3 7262.3 7274.2 7424.3 7437.5 6807.9 6837.8 6922.9 7035.3 7044.5 4318.9 4352.9 4353.7 4363.6 4428.7 1653.5 1698.6 1820.2 1851.1 1926.1 811.4 856.2 885.2 894.2 953.2 17255.7 17297.0 17353.6 17633.9 17851.0 876.6 913.2 917.0 925.8 947.2 9671.2 9673.8 9773.4 9872.2 9892.5 367939.0 368091.0 378289.0 388123.0 389178.0 80411.0 80437.6 82958.4 83283.0 83872.0 869.5 879.8 886.5 894.8 903.3 15016.4 15519.8 15770.7 15826.4 16008.2 36579.0 37009.3 37382.3 37483.6 38185.8 49805.3 52026.5 52321.7 52692.7 53008.5 7558.2 7573.4 7574.9 7691.1 7833.8 8763.6 10862.7 11397.3 11858.2 12026.5 9885.5 10001.8 10396.4 10592.8 10784.8 10011.9 10035.3 10295.3 10325.4 10336.9 10008.4 10280.3 10345.6 10473.9 10633.5 7098.7 7202.2 7672.7 7695.1 7802.0 9775.7 9869.9 10114.0 10149.4 10307.0 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#3] mootools.html Cycles:180 Average:5235.02 Median:4795.00 stddev:2988.72 (62.3%) stddev-sans-first:2983.05 05:40:39 INFO - PROCESS | 30461 | Values: 1377.2 1401.7 1497.5 1697.7 1729.8 7010.0 7495.4 7780.1 8333.6 8338.8 7698.3 7719.9 7905.6 7959.8 8005.7 2156.1 2206.8 2208.4 2209.9 2222.5 2153.5 2177.6 2213.9 2215.2 2216.6 2181.8 2196.3 2200.3 2201.0 2229.9 2133.7 2134.9 2138.7 2142.2 2148.9 2114.3 2139.4 2141.0 2152.9 2154.0 7765.6 7858.3 7864.8 7870.3 7885.2 4384.1 4474.1 4482.5 4522.5 4531.2 2845.4 2870.3 2938.7 2942.8 2950.8 910.8 949.6 953.1 954.6 966.0 10628.6 10843.8 10875.7 10912.7 10922.5 4102.4 4194.3 4248.6 4328.5 4354.7 9397.9 9437.5 9451.4 9462.9 9469.7 4557.2 4564.7 4586.2 4588.7 4602.7 3657.3 3980.3 4101.4 4118.2 4146.6 3722.5 3737.1 3816.9 3824.8 3872.3 1160.1 1227.1 1228.9 1233.8 1234.0 724.4 790.0 838.3 839.3 849.2 4987.3 5160.0 5167.2 5193.8 5260.3 874.7 898.8 900.4 902.9 905.6 3617.5 3619.2 3681.7 3726.2 3762.2 9782.8 10037.6 10079.7 10117.7 10292.1 9966.2 9971.9 9978.2 10013.0 10024.6 7403.4 7455.8 7568.9 7577.9 7638.6 5042.8 5064.9 5086.9 5089.2 5539.6 8793.7 8883.2 9021.5 9212.2 9327.5 9372.1 9445.0 9463.4 9640.4 9647.1 6766.0 7091.6 7308.5 7507.1 7759.7 7702.7 7773.3 7773.9 7775.6 7840.6 6948.3 7085.0 7176.7 7178.4 7191.2 6999.2 7000.5 7017.6 7096.4 7123.5 5791.3 5905.4 5975.7 5987.5 6083.4 4502.0 4508.6 4542.5 4548.9 4552.5 4429.1 4533.5 4552.0 4587.2 4597.3 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#4] prototype.html Cycles:180 Average:4463.55 Median:5078.33 stddev:1300.55 (25.6%) stddev-sans-first:1265.72 05:40:39 INFO - PROCESS | 30461 | Values: 279.9 285.5 293.3 294.8 298.9 4924.5 5035.2 5075.4 5123.4 5142.2 5054.6 5059.2 5078.1 5078.6 5082.7 3945.2 3971.0 3991.6 3992.6 4008.7 3928.0 3978.9 4014.2 4017.7 4026.5 3962.5 3963.5 3969.4 3975.2 3976.9 3981.3 3986.6 3993.9 4017.7 4020.4 3553.1 3555.0 3561.9 3574.7 3584.5 4893.4 4974.9 4983.4 5010.0 5075.7 4561.1 4570.6 4584.4 4593.5 4603.6 5342.4 5346.5 5347.6 5376.6 5393.2 3761.9 3769.0 3788.5 3807.3 3839.4 5575.6 5582.1 5587.6 5616.7 5627.7 3912.8 3924.5 3937.5 3941.7 3965.2 3885.3 4005.2 4021.4 4026.5 4032.4 4526.4 4555.7 4559.5 4564.8 4565.5 5345.7 5376.7 5390.4 5397.5 5406.0 1275.3 1307.9 1346.0 1350.7 1362.6 921.5 924.2 937.1 942.1 950.8 4502.2 4603.6 4605.7 4606.4 4613.6 5466.2 5488.5 5491.9 5493.9 5509.6 4530.3 4650.6 4653.0 4664.9 4693.3 2979.5 2981.4 3004.6 3005.8 3011.8 5183.9 5226.2 5263.8 5268.9 5270.2 5422.6 5715.5 5725.0 5731.9 5734.3 5229.2 5244.9 5247.8 5254.5 5271.2 5603.4 5606.9 5611.9 5644.8 5657.5 5238.5 5499.6 5499.6 5514.3 5523.9 5217.2 5223.9 5238.7 5253.7 5267.6 3810.9 3877.2 3905.6 3906.9 3924.3 5265.9 5335.4 5466.3 5595.5 5602.7 5365.5 5387.3 5394.0 5398.8 5422.5 5305.9 5368.2 5370.2 5375.9 5411.2 5195.0 5243.7 5265.6 5275.8 5277.0 5394.9 5404.2 5417.9 5419.9 5433.7 5321.3 5333.2 5337.3 5359.9 5391.9 05:40:39 INFO - PROCESS | 30461 | 05:40:39 INFO - PROCESS | 30461 | [#5] yui.html Cycles:180 Average:16593.24 Median:40029.70 stddev:23018.42 (57.5%) stddev-sans-first:23051.75 05:40:39 INFO - PROCESS | 30461 | Values: 621.4 658.9 682.2 707.1 740.2 12881.0 13458.6 13510.9 13855.2 13869.0 12853.1 12883.0 12932.4 12984.2 12991.9 642.0 772.4 775.4 811.3 811.5 799.5 804.2 807.3 810.8 812.1 843.4 846.4 850.5 850.7 851.2 837.8 838.3 839.4 842.8 843.3 614.0 617.5 617.6 617.6 618.4 12978.7 13046.6 13076.7 13082.4 13125.8 12979.6 13050.4 13059.3 13073.7 13288.3 10460.9 10480.5 10524.4 10546.8 10716.1 3167.0 3216.5 3216.8 3218.7 3252.5 58830.7 59806.7 60103.4 60440.7 60528.4 10456.2 10494.4 10523.3 10667.1 10821.4 20260.4 20507.7 20508.8 20555.2 20571.5 6477.5 6623.9 6650.2 6665.2 6868.6 3593.8 3676.5 3737.5 3764.2 3815.4 2825.2 2914.1 2928.9 2935.4 2940.1 498.5 518.2 518.6 523.6 525.6 552.1 555.5 583.1 587.7 591.6 7405.0 7419.6 7485.6 7488.5 7601.5 550.2 571.9 579.0 583.8 602.5 3703.8 3747.5 3794.9 3851.8 3906.1 52474.2 84690.0 87293.0 92968.5 93574.0 80799.6 82669.0 84045.2 84291.0 85873.6 70967.6 71162.3 71825.5 72361.0 72493.0 6890.6 7057.5 7277.4 7322.1 7580.1 30406.7 36527.6 38182.2 39073.4 45304.0 39533.6 40525.8 43198.8 49344.0 61237.0 11527.5 11611.2 11721.7 11733.2 11874.5 12907.4 13216.4 13241.2 13391.2 13408.5 11316.3 11381.5 11401.8 11457.6 11508.1 11556.2 11857.5 11859.2 12053.6 12259.7 11032.2 11172.3 11368.4 11565.2 12099.4 9547.5 9802.2 9884.7 10130.5 10250.6 9944.9 10051.5 10229.0 10295.8 10370.9 05:40:39 INFO - PROCESS | 30461 | -------- Summary: end -------- 05:40:39 INFO - PROCESS | 30461 | 05:40:40 INFO - TEST-INFO | 30461: exit 0 05:40:40 INFO - TEST-OK | dromaeo_css | took 1116087ms 05:40:40 INFO - TEST-START | kraken 05:40:40 INFO - operating with platform_type : linux_ 05:40:40 INFO - Initialising browser for kraken test... 05:40:40 INFO - TEST-INFO | started process 30700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo5934k/profile http://localhost:35159/getInfo.html) 05:40:45 INFO - PROCESS | 30700 | __metrics Screen width/height:1600/1200 05:40:45 INFO - PROCESS | 30700 | colorDepth:24 05:40:45 INFO - PROCESS | 30700 | Browser inner width/height: 1024/697 05:40:45 INFO - PROCESS | 30700 | __metrics 05:40:46 ERROR - PROCESS | 30700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:40:47 INFO - TEST-INFO | 30700: exit 0 05:40:47 INFO - Browser initialized. 05:40:47 INFO - Running cycle 1/1 for kraken test... 05:40:47 INFO - TEST-INFO | started process 30823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo5934k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:59 INFO - PROCESS | 30823 | RSS: Main: 170131456 05:40:59 INFO - PROCESS | 30823 | 05:41:01 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35159/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:02 INFO - PROCESS | 30823 | RSS: Main: 175370240 05:41:02 INFO - PROCESS | 30823 | 05:41:05 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35159/tests/kraken/driver.html?testName=audio-dft) 05:41:06 INFO - PROCESS | 30823 | RSS: Main: 174813184 05:41:06 INFO - PROCESS | 30823 | 05:41:09 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35159/tests/kraken/driver.html?testName=audio-fft) 05:41:09 INFO - PROCESS | 30823 | RSS: Main: 169299968 05:41:09 INFO - PROCESS | 30823 | 05:41:11 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35159/tests/kraken/driver.html?testName=audio-oscillator) 05:41:12 INFO - PROCESS | 30823 | RSS: Main: 169758720 05:41:12 INFO - PROCESS | 30823 | 05:41:14 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:15 INFO - PROCESS | 30823 | RSS: Main: 170295296 05:41:15 INFO - PROCESS | 30823 | 05:41:18 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35159/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:19 INFO - PROCESS | 30823 | RSS: Main: 170647552 05:41:19 INFO - PROCESS | 30823 | 05:41:22 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35159/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:23 INFO - PROCESS | 30823 | RSS: Main: 168378368 05:41:23 INFO - PROCESS | 30823 | 05:41:26 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35159/tests/kraken/driver.html?testName=json-parse-financial) 05:41:26 INFO - PROCESS | 30823 | RSS: Main: 169771008 05:41:26 INFO - PROCESS | 30823 | 05:41:28 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:29 INFO - PROCESS | 30823 | RSS: Main: 170127360 05:41:29 INFO - PROCESS | 30823 | 05:41:31 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:31 INFO - PROCESS | 30823 | RSS: Main: 170389504 05:41:31 INFO - PROCESS | 30823 | 05:41:33 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:34 INFO - PROCESS | 30823 | RSS: Main: 170770432 05:41:34 INFO - PROCESS | 30823 | 05:41:37 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:38 INFO - PROCESS | 30823 | RSS: Main: 171196416 05:41:38 INFO - PROCESS | 30823 | 05:41:41 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:41 INFO - PROCESS | 30823 | RSS: Main: 171241472 05:41:41 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | Cycle 1(1): loaded http://localhost:35159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35159/tests/kraken/driver.html?testName=ai-astar) 05:41:43 INFO - PROCESS | 30823 | RSS: Main: 171692032 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | __start_tp_report 05:41:43 INFO - PROCESS | 30823 | _x_x_mozilla_page_load 05:41:43 INFO - PROCESS | 30823 | _x_x_mozilla_page_load_details 05:41:43 INFO - PROCESS | 30823 | |i|pagename|runs| 05:41:43 INFO - PROCESS | 30823 | |0;ai-astar;109;116;113;117;118;116;118;115;116;115 05:41:43 INFO - PROCESS | 30823 | |1;audio-beat-detection;158;129;146;170;128;156;152;127;189;125 05:41:43 INFO - PROCESS | 30823 | |2;audio-dft;164;166;165;174;166;164;164;164;165;164 05:41:43 INFO - PROCESS | 30823 | |3;audio-fft;76;76;78;150;77;76;78;75;165;77 05:41:43 INFO - PROCESS | 30823 | |4;audio-oscillator;86;85;140;84;84;85;140;84;86;133 05:41:43 INFO - PROCESS | 30823 | |5;imaging-gaussian-blur;119;118;118;118;117;118;118;118;119;118 05:41:43 INFO - PROCESS | 30823 | |6;imaging-darkroom;148;148;148;148;148;148;147;149;149;148 05:41:43 INFO - PROCESS | 30823 | |7;imaging-desaturate;95;96;97;96;95;96;95;95;96;95 05:41:43 INFO - PROCESS | 30823 | |8;json-parse-financial;65;65;65;65;65;66;65;67;64;64 05:41:43 INFO - PROCESS | 30823 | |9;json-stringify-tinderbox;64;66;65;66;66;65;66;65;66;65 05:41:43 INFO - PROCESS | 30823 | |10;stanford-crypto-aes;91;80;78;78;79;88;85;88;84;84 05:41:43 INFO - PROCESS | 30823 | |11;stanford-crypto-ccm;132;133;130;140;132;133;131;147;184;133 05:41:43 INFO - PROCESS | 30823 | |12;stanford-crypto-pbkdf2;166;167;174;165;172;168;166;169;169;166 05:41:43 INFO - PROCESS | 30823 | |13;stanford-crypto-sha256-iterative;68;68;73;74;68;73;69;67;67;66 05:41:43 INFO - PROCESS | 30823 | __end_tp_report 05:41:43 INFO - PROCESS | 30823 | __start_cc_report 05:41:43 INFO - PROCESS | 30823 | _x_x_mozilla_cycle_collect,1002 05:41:43 INFO - PROCESS | 30823 | __end_cc_report 05:41:43 INFO - PROCESS | 30823 | __startTimestamp1467290503727__endTimestamp 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | ------- Summary: start ------- 05:41:43 INFO - PROCESS | 30823 | Number of tests: 14 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:2.67 (2.3%) stddev-sans-first:1.58 05:41:43 INFO - PROCESS | 30823 | Values: 109.0 116.0 113.0 117.0 118.0 116.0 118.0 115.0 116.0 115.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:21.29 (13.8%) stddev-sans-first:22.27 05:41:43 INFO - PROCESS | 30823 | Values: 158.0 129.0 146.0 170.0 128.0 156.0 152.0 127.0 189.0 125.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.06 (1.9%) stddev-sans-first:3.19 05:41:43 INFO - PROCESS | 30823 | Values: 164.0 166.0 165.0 174.0 166.0 164.0 164.0 164.0 165.0 164.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.50 stddev:34.30 (44.8%) stddev-sans-first:35.83 05:41:43 INFO - PROCESS | 30823 | Values: 76.0 76.0 78.0 150.0 77.0 76.0 78.0 75.0 165.0 77.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.50 stddev:25.59 (30.3%) stddev-sans-first:26.58 05:41:43 INFO - PROCESS | 30823 | Values: 86.0 85.0 140.0 84.0 84.0 85.0 140.0 84.0 86.0 133.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 05:41:43 INFO - PROCESS | 30823 | Values: 119.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:41:43 INFO - PROCESS | 30823 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 149.0 148.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:41:43 INFO - PROCESS | 30823 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:41:43 INFO - PROCESS | 30823 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 67.0 64.0 64.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 05:41:43 INFO - PROCESS | 30823 | Values: 64.0 66.0 65.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.50 stddev:4.62 (5.5%) stddev-sans-first:4.03 05:41:43 INFO - PROCESS | 30823 | Values: 91.0 80.0 78.0 78.0 79.0 88.0 85.0 88.0 84.0 84.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:133.00 stddev:16.46 (12.4%) stddev-sans-first:17.23 05:41:43 INFO - PROCESS | 30823 | Values: 132.0 133.0 130.0 140.0 132.0 133.0 131.0 147.0 184.0 133.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:2.90 (1.7%) stddev-sans-first:2.96 05:41:43 INFO - PROCESS | 30823 | Values: 166.0 167.0 174.0 165.0 172.0 168.0 166.0 169.0 169.0 166.0 05:41:43 INFO - PROCESS | 30823 | 05:41:43 INFO - PROCESS | 30823 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:2.91 (4.2%) stddev-sans-first:3.05 05:41:43 INFO - PROCESS | 30823 | Values: 68.0 68.0 73.0 74.0 68.0 73.0 69.0 67.0 67.0 66.0 05:41:43 INFO - PROCESS | 30823 | -------- Summary: end -------- 05:41:43 INFO - PROCESS | 30823 | 05:41:44 INFO - TEST-INFO | 30823: exit 0 05:41:44 INFO - TEST-OK | kraken | took 64146ms 05:41:44 INFO - SUITE-END | took 1180s 05:41:44 INFO - Completed test suite (00:19:40) 05:41:44 INFO - javascript benchmark 05:41:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6449.736562164072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.6443230163927, 2675.7993150513717, 2678.611601317809, 2711.3628297350133, 2717.538018536847, 4839.370881785372, 4880.755962201889, 4909.386326709161, 4930.137225985452, 4960.1319769040365, 4714.811407543702, 4902.975485122578, 4917.409910810698, 4930.506949305068, 4977.626677999156, 4444.599986001259, 4491.281394976788, 4606.032733126048, 4609.193391156534, 4619.422572178478, 523.7884709836052, 4425.77871106445, 4502.482214545336, 4560.863174104766, 4600.953990460086, 4473.888152796174, 4475.1049790042125, 4478.664100192483, 4499.460064792213, 4538.887972446739, 4391.934120988188, 4482.327650852366, 4497.617702495292, 4507.797149128264, 4515.480719717241, 4362.236608593484, 4393.6045755881805, 4411.316245981878, 4412.426384570017, 4458.665600080007, 4767.165745994472, 4835.419749630032, 4843.22508398658, 4867.342908707315, 4890.437599676012, 5114.360704911886, 5179.974100129475, 5183.792648294101, 5274.630775845692, 5316.4683531646915, 5208.322918020633, 5246.396664383607, 5310.44240354761, 5315.867103322409, 5357.517823395874, 4817.807287708488, 4914.4839791821705, 4933.629977751683, 4936.6050715943, 4939.110960027229, 5166.689998600096, 5277.788888444419, 5322.787088516493, 5354.732263386815, 5405.054115529767, 5146.845594632092, 5150.768215430315, 5152.201408781645, 5153.742312884341, 5156.226566015128, 5191.740412979336, 5215.16557350822, 5229.764660590283, 5241.73791310433, 5302.443243459458, 5055.469175736494, 5141.820036298786, 5144.485551444825, 5165.845024649267, 5187.0922588546855, 5043.924341134886, 5127.333446651912, 5134.460881607452, 5137.845864624067, 5138.563222126161, 4434.445694288214, 4452.376667266585, 4467.262901621196, 4470.173017991617, 4495.617872480876, 3763.9623603764157, 3790.6209379062425, 3837.213371258885, 3839.3665045267776, 3918.7452815567467, 4501.954980450154, 4516.638668906479, 4522.412086428809, 4537.0925814837165, 4580.427446569179, 5270.762815673227, 5298.470152984671, 5308.522232999048, 5319.973400133052, 5327.200919862052, 4382.780860956939, 4439.66702497314, 4477.664175186874, 4504.909901801946, 4562.110388474282, 4676.7661616919695, 4696.178168820443, 4747.501512341223, 4790.449098353664, 4818.084563932912, 4899.755012249373, 4908.533689299654, 4915.852524424273, 4925.5074492551175, 4962.0, 5054.519820617035, 5202.193659982709, 5250.973745131403, 5265.921011184759, 5295.973520132375, 4917.188663870421, 4931.3096166536, 4937.358143441474, 4958.404991401055, 4994.825181118644, 5217.295665085165, 5217.921731174111, 5235.554977826928, 5237.2667826505085, 5241.947580524146, 5119.0529751996, 5251.291075704731, 5289.0, 5305.628605997543, 5326.4407237241085, 5148.253503242084, 5154.871128221825, 5165.535101840853, 5168.870778230424, 5198.6880787152895, 5017.0, 5143.382794064736, 5144.6913185209005, 5173.40505841833, 5177.456367081402, 4824.541668541483, 4884.877878053077, 4945.530174633404, 4949.727764972817, 4967.975160124176, 5096.0, 5100.336956195819, 5101.20931255656, 5103.132467480612, 5103.948960510347, 4991.47589503097, 5004.424491183415, 5006.724630145377, 5026.723530205873, 5082.771275292546], "value": 4767.949222740539, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9025571265771, 561.0882316236116, 589.5489950188105, 602.2652364115778, 627.811656503049, 35467.2906541869, 39259.607403925955, 39465.4080188797, 39497.60502394975, 39826.0, 39283.0, 39876.40185397222, 39882.60117398825, 39902.8004859976, 39926.600733992724, 7902.920970790276, 8007.599620019005, 8014.599270036504, 8025.839483210332, 8044.959775201116, 7894.921050789505, 7971.521708697468, 7973.840523189533, 7988.920110798876, 7995.720149794758, 7961.36309095271, 7989.480683755566, 7991.840163196762, 8041.798955026142, 8042.356611471068, 7924.762257132295, 7981.6009199540085, 7989.800254993643, 7999.0801057877925, 8001.079875814297, 7867.252611002003, 7903.565303908283, 7906.6837326506875, 7949.6025198739835, 7977.56123413212, 38482.80758596189, 39070.804645976874, 39116.60883391158, 39124.021899452455, 39282.41076383857, 3168.207948012997, 3229.5640088587975, 3340.615829179651, 3352.9832350838333, 3393.8472768725464, 29640.40719185626, 30064.24839379033, 30480.390392192254, 30902.0, 31817.52273715896, 3394.8472318745717, 3422.709069729076, 3454.7408944329277, 3459.60214575322, 3512.227309991798, 255593.0, 256671.0, 257000.7149964257, 257465.0, 258918.0, 31661.99211074944, 52871.0, 52939.470605293456, 53139.46860531423, 53344.73327633415, 32558.83720581382, 34139.31721365608, 34327.0, 34327.141821454665, 34544.0, 12590.43343049565, 12689.619311420673, 12696.301703406216, 12750.617481475385, 12849.550265740841, 10392.168626509861, 10459.790804183875, 10563.683089507327, 10581.57673693059, 10612.09797167234, 7952.324052455606, 7989.121196668362, 8011.278984891388, 8081.232282933112, 8106.797330066795, 3120.8283544405276, 3184.8726050958167, 3196.888108916177, 3215.887443939451, 3234.369297986917, 898.2589363774912, 982.9164521015794, 991.3358050106445, 998.4109375468508, 1010.2524132142308, 29230.415391692473, 29331.266718332212, 29360.853195733886, 29666.55500167499, 29913.85043074771, 930.497531333086, 984.1782111936614, 1021.5505177721778, 1022.223110436074, 1047.6856942917095, 15180.848191518164, 15375.692486150214, 15419.61450963735, 15487.225638718019, 15559.688806223812, 423178.0, 423699.0, 428487.0, 428950.0, 431524.0, 50630.74684626627, 50885.23672144921, 51115.74442127765, 51177.0, 51248.48751512437, 1189.8238747553817, 1213.4721396192685, 1232.648695121904, 1235.9505619775289, 1240.5968060380412, 27133.1860044199, 28549.714502855535, 28644.0, 28777.712222877504, 28925.276868078465, 43197.352039720055, 43433.78283108564, 43480.34779478247, 43622.345664815686, 43688.12623747444, 339529.0, 339794.0, 342034.0, 343173.0, 344424.0, 25204.495910082063, 25536.23391298264, 26271.0, 26411.471770564865, 27545.586816197374, 42245.577544224165, 42384.0, 43510.0, 44066.779666101465, 44197.779011104736, 36883.63116368802, 37161.62838371582, 37461.81269093637, 37846.24307513779, 38602.42096368501, 36811.3434895425, 37526.0, 37590.43614345841, 37699.43450848185, 37724.24551509009, 31526.0, 36384.454233187054, 36872.0, 37201.25597488089, 37748.0, 31714.682853171173, 34259.14352141217, 34454.136954671776, 34479.4828077574, 34649.82675086709, 26116.98618635449, 26241.475170496866, 26430.471390572464, 26818.329541761614, 26819.731802681723], "value": 16862.41796578028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.7312198655974, 371.1278495535492, 373.9027852758283, 387.7421514692729, 389.08370786797093, 15959.441419550318, 17074.91462542687, 17297.913510432445, 17905.283788648438, 17978.910105449486, 13312.866871331284, 13596.0, 14381.78427323591, 14392.424303027892, 15038.774418383706, 4529.433820772403, 4815.3258543803895, 4870.683405578626, 4872.8050877965015, 4874.951250487503, 3425.45192769157, 4722.05558888222, 5060.848174554751, 5310.867228319304, 5347.0909945309195, 5388.0, 5389.51494365507, 5397.568194544427, 5403.054465468547, 5422.9728851355685, 5067.442581316052, 5380.838574842761, 5395.10980688186, 5404.648697834628, 5459.918101228484, 5189.3772747270195, 5216.321878155815, 5256.0, 5279.736013199363, 5303.549198318109, 20302.492437689027, 20524.79475205244, 21131.78868211329, 21288.0, 21438.57122857534, 1772.7340898865145, 1898.9240430382906, 1940.553672655297, 2173.989095070784, 2208.5803697297624, 9380.296477764196, 9493.05069493052, 9586.712398628053, 9817.165540929029, 13597.0, 1727.5422013166522, 1734.4276388791668, 1752.3165965273554, 1759.225940586138, 1782.1801971093312, 64468.0, 71127.64436177838, 71520.0, 72188.0, 72615.0, 9999.700008999596, 10058.245631577662, 10082.848757268646, 10188.847167292497, 10463.215258855616, 13997.3701183447, 14129.85870141306, 14133.081349712442, 14186.929065354607, 14216.360263788154, 7229.349358557755, 7262.31008054234, 7274.236205198484, 7424.294692004359, 7437.479376443597, 6807.863842723217, 6837.760678376332, 6922.930770692329, 7035.296470353026, 7044.471664625174, 4318.913621727548, 4352.891177720519, 4353.651707863363, 4363.629091527256, 4428.73427594339, 1653.5204790610828, 1698.558374822555, 1820.2355010895456, 1851.1484717030316, 1926.1428664244556, 811.3549727966281, 856.1908995998846, 885.1900511032334, 894.2264940826138, 953.1802649721234, 17255.74116388255, 17297.0, 17353.56616084608, 17633.911830440764, 17851.0, 876.6230520876085, 913.1872633356318, 916.9954150229206, 925.8055808280202, 947.1570302430843, 9671.17794987434, 9673.758156046155, 9773.41359518431, 9872.160866326443, 9892.455914924749, 367939.0, 368091.0, 378289.0, 388123.0, 389178.0, 80411.0, 80437.59781201057, 82958.43728594865, 83283.0, 83872.0, 869.5130726793017, 879.7668617816283, 886.4592598514901, 894.789724414762, 903.3089686389917, 15016.399344026117, 15519.767203492183, 15770.68458630798, 15826.36694532252, 16008.19959002022, 36579.0, 37009.25981480409, 37382.25235495329, 37483.625163748016, 38185.80907095447, 49805.25292120549, 52026.47973520216, 52321.7383913078, 52692.736536317076, 53008.46991530035, 7558.168601453725, 7573.431992600687, 7574.886376704244, 7691.115676659254, 7833.764987050397, 8763.649454021768, 10862.674119776419, 11397.316161030032, 11858.229215100991, 12026.518939242333, 9885.512114646885, 10001.849972250277, 10396.428196449267, 10592.788144237225, 10784.838227426751, 10011.899881001096, 10035.34770239932, 10295.330803497749, 10325.432101234504, 10336.948315258376, 10008.44953527563, 10280.331778434676, 10345.601324364667, 10473.895261047597, 10633.521491532745, 7098.72222999865, 7202.171750248788, 7672.7314543992925, 7695.076590809139, 7802.024746906637, 9775.657851975147, 9869.851952220866, 10114.0, 10149.441780702133, 10307.0], "value": 8196.699511940004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.2218696436512, 1401.6776141487458, 1497.460914070935, 1697.6519813438247, 1729.8010728766187, 7009.964950175255, 7495.437842161832, 7780.1052878918945, 8333.624986875597, 8338.833223335538, 7698.34564062054, 7719.884201736979, 7905.644246008929, 7959.801004974878, 8005.719799807008, 2156.0621129808505, 2206.8455208135438, 2208.436848603612, 2209.9116035358566, 2222.5221577360862, 2153.493928926701, 2177.6080305544997, 2213.9225127120553, 2215.191455118878, 2216.556688662266, 2181.8472706910525, 2196.3081629286726, 2200.284907405092, 2200.9889950550305, 2229.9331020069344, 2133.669281261407, 2134.871907685536, 2138.7219661443914, 2142.2073832681854, 2148.9140434382607, 2114.2811444108925, 2139.443744626393, 2141.0, 2152.8923553822247, 2153.967690484644, 7765.611719414063, 7858.292753652198, 7864.842703145962, 7870.331021863149, 7885.211478852127, 4384.079343337903, 4474.0604473060375, 4482.462104547442, 4522.4573051234065, 4531.184386810372, 2845.445138198052, 2870.3111253299267, 2938.6620538637903, 2942.823430594171, 2950.822950622948, 910.7540963939699, 949.6343907595557, 953.0707560128889, 954.5799848066829, 965.9664159349499, 10628.627998020032, 10843.783124337548, 10875.673729788119, 10912.672619821418, 10922.508487118099, 4102.425660407545, 4194.328907374806, 4248.596383343577, 4328.523862375137, 4354.716943398669, 9397.919239287432, 9437.480938548308, 9451.385659932082, 9462.858057129148, 9469.66856160031, 4557.202489564313, 4564.657650676212, 4586.220342541709, 4588.747618880993, 4602.7008244464005, 3657.2685462907525, 3980.3432433648704, 4101.425800387948, 4118.155778065489, 4146.647534959562, 3722.4974628424816, 3737.1404576947452, 3816.923661526754, 3824.827882745283, 3872.3223435898603, 1160.1356989043047, 1227.061298106949, 1228.9446974886152, 1233.8334324866207, 1233.9814902776466, 724.4277021153335, 789.973035054427, 838.2748922182391, 839.3075712537059, 849.1762989899787, 4987.301777751118, 5159.974200128975, 5167.224916262516, 5193.818216362409, 5260.263563101169, 874.6938571500051, 898.7842917699705, 900.4372267332917, 902.8826252587122, 905.6151135767273, 3617.4935509028755, 3619.2218672985437, 3681.668649821529, 3726.1988672435014, 3762.191128907243, 9782.804343913223, 10037.64868229623, 10079.69760907174, 10117.747056323504, 10292.125169360539, 9966.152877005536, 9971.900280997243, 9978.201743860474, 10013.048760367754, 10024.649137280161, 7403.444741644398, 7455.776326710207, 7568.886466703004, 7577.924220757832, 7638.618069096523, 5042.798288068583, 5064.873378165576, 5086.898262034812, 5089.185730283285, 5539.612227144223, 8793.736187914374, 8883.200511953955, 9021.503817290111, 9212.216961558343, 9327.533623318672, 9372.109649583279, 9445.0, 9463.432194068379, 9640.373375730554, 9647.1317581418, 6766.0, 7091.574505529685, 7308.524945878501, 7507.136679281953, 7759.72840950564, 7702.691892324468, 7773.3004029637605, 7773.883391749016, 7775.572343520935, 7840.647170877211, 6948.270431604608, 7085.0, 7176.748813791701, 7178.4257259420165, 7191.2449192834, 6999.230084690578, 7000.47496437759, 7017.614031228127, 7096.396806271318, 7123.536970096927, 5791.276090488689, 5905.379935106924, 5975.701214939322, 5987.461128498456, 6083.391660834058, 4502.0, 4508.571685689854, 4542.545745425563, 4548.863534093983, 4552.5447455255535, 4429.069895322018, 4533.478649955297, 4552.021315417202, 4587.151376995266, 4597.333386658983], "value": 4195.801260016541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.90063527447745, 285.4505077725379, 293.29316347602276, 294.80395536967916, 298.926762943079, 4924.482929292418, 5035.219540971146, 5075.39095308563, 5123.410807757109, 5142.202958541423, 5054.570361519266, 5059.241113832927, 5078.085944529983, 5078.568321692661, 5082.720450375228, 3945.171513982067, 3971.0, 3991.6407523322896, 3992.6007399260134, 4008.719389642726, 3928.0, 3978.9403158952496, 4014.1770936957855, 4017.7388469749517, 4026.4966879140106, 3962.5046869141356, 3963.4847469828883, 3969.412235105952, 3975.2248311579256, 3976.9204615907665, 3981.2634662587516, 3986.6013398660193, 3993.8801835944823, 4017.738846974937, 4020.4170395292813, 3553.076200187944, 3555.0, 3561.8753343632848, 3574.7140228781896, 3584.480250363709, 4893.363862697862, 4974.850754477336, 4983.377077865267, 5010.0, 5075.670081444731, 4561.133384656904, 4570.611498022672, 4584.426946631671, 4593.5406459354135, 4603.631709463235, 5342.385625653061, 5346.492083252085, 5347.598930080259, 5376.569874410038, 5393.164059570773, 3761.9090463765474, 3768.9623103768886, 3788.5264341957254, 3807.276617442677, 3839.4432807243074, 5575.553955683536, 5582.078956972095, 5587.608867379285, 5616.691081990489, 5627.746751396197, 3912.8065939888606, 3924.4898163238595, 3937.5078115235597, 3941.684665226775, 3965.1871366369824, 3885.339492286318, 4005.239004589177, 4021.3565829467143, 4026.5369482509886, 4032.395140728914, 4526.388937493396, 4555.658325625525, 4559.452865656142, 4564.817407303671, 4565.5206203348835, 5345.679259244458, 5376.736466930268, 5390.380106287827, 5397.46172340881, 5406.0, 1275.2858399296424, 1307.875751803577, 1345.9636080218177, 1350.743358761832, 1362.5639795265618, 921.4655499810094, 924.2190349154953, 937.0816599732165, 942.1097063275276, 950.7860731335394, 4502.212112880233, 4603.562661547147, 4605.700629459075, 4606.378138951266, 4613.63090952723, 5466.234727138204, 5488.53347465462, 5491.945080549143, 5493.862653433616, 5509.614326997072, 4530.252508336088, 4650.6046986005895, 4652.97673511637, 4664.906701865943, 4693.296005599187, 2979.5381715834083, 2981.4484320400798, 3004.5643381709965, 3005.8046226995175, 3011.7741169412384, 5183.948160518422, 5226.216067589892, 5263.842084737464, 5268.947310526845, 5270.209468579744, 5422.620416570802, 5715.5427565794635, 5724.971375143181, 5731.876127510517, 5734.254546908875, 5229.241759944863, 5244.868878278074, 5247.772619838772, 5254.474552544715, 5271.235670827785, 5603.439656034364, 5606.85982850432, 5611.943880561143, 5644.774209031592, 5657.4908258256955, 5238.476152384731, 5499.615026948075, 5499.642523235977, 5514.255575497256, 5523.8895222096135, 5217.165253559412, 5223.92164117531, 5238.738063096754, 5253.658512196695, 5267.57859371257, 3810.9237815244096, 3877.224555088937, 3905.5785413044096, 3906.902327441837, 3924.293627147141, 5265.868353291198, 5335.35975682905, 5466.289382380265, 5595.468430499096, 5602.691851948182, 5365.463453654604, 5387.299651045339, 5393.9730301348245, 5398.811041613525, 5422.48486393792, 5305.893882122413, 5368.208531563643, 5370.2213179089595, 5375.919361209507, 5411.242426060276, 5194.97402512985, 5243.711595862112, 5265.552428043659, 5275.762590683352, 5276.973615131899, 5394.9460505394445, 5404.216388623706, 5417.891642167056, 5419.918701219406, 5433.701146436826, 5321.281626980308, 5333.226682131147, 5337.332833395825, 5359.946400535945, 5391.9460805391445], "value": 4041.769707647343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.4158690830619, 658.9176352955883, 682.1643486728755, 707.0666719929692, 740.1931894235285, 12881.0, 13458.596242112728, 13510.93244533776, 13855.168689878601, 13869.0, 12853.100282980171, 12883.033772467055, 12932.353382330894, 12984.220946743179, 12991.935040324808, 642.0401499757869, 772.4013889235831, 775.3835700618022, 811.3306522119245, 811.4968719393984, 799.4963173200904, 804.1556365815899, 807.3097501636105, 810.7932477218301, 812.0904586862722, 843.3674743942044, 846.4413487098516, 850.4684572142411, 850.7277671145235, 851.1658574596898, 837.7612380471536, 838.3460900497622, 839.4040231435688, 842.8314337132598, 843.304273973974, 614.0420943328422, 617.478230894893, 617.555360140698, 617.604732970899, 618.4186864347544, 12978.675533111653, 13046.608601741867, 13076.673083172902, 13082.411291491811, 13125.803112953314, 12979.610611681665, 13050.412731427108, 13059.347032648424, 13073.738525229443, 13288.3355832208, 10460.895391046068, 10480.528376223088, 10524.36853788775, 10546.841797373045, 10716.142708583373, 3167.0, 3216.469282568397, 3216.758743094277, 3218.6942240487115, 3252.5446437498767, 58830.70584647092, 59806.70096649532, 60103.398966010216, 60440.69779651117, 60528.39471605272, 10456.163506919429, 10494.370337779605, 10523.315984460985, 10667.14662826972, 10821.404822734825, 20260.392188234375, 20507.69238461424, 20508.79491205069, 20555.177792888415, 20571.485712857, 6477.514186436036, 6623.9006414903815, 6650.20197576294, 6665.200175978914, 6868.553544019623, 3593.8023408712247, 3676.5036720042986, 3737.5141231640255, 3764.247150569897, 3815.37046387343, 2825.166575860126, 2914.0529327968493, 2928.8828446862312, 2935.383569450439, 2940.0738767288235, 498.464151037636, 518.1709265175689, 518.6214063733496, 523.5575938332104, 525.6005435868691, 552.1303946284618, 555.4972749661563, 583.0525396231125, 587.7355190164443, 591.6479694581717, 7405.0, 7419.591922444318, 7485.5508669480005, 7488.513246638951, 7601.505902116345, 550.1829782772579, 571.865611581278, 579.0445764488543, 583.804425517448, 602.4668168670757, 3703.79629120401, 3747.4940882980995, 3794.905127371783, 3851.78815165163, 3906.121122747416, 52474.21288680673, 84690.0, 87293.0, 92968.53515732514, 93574.0, 80799.59600202079, 82669.0, 84045.15954840374, 84291.0, 85873.57063214644, 70967.6451617749, 71162.28837711661, 71825.53570178708, 72361.0, 72493.0, 6890.621015844176, 7057.470689698191, 7277.417806575567, 7322.121345438582, 7580.090389153337, 30406.695933040388, 36527.634723653486, 38182.23635527218, 39073.41389879211, 45304.0, 39533.604663952996, 40525.79737101296, 43198.78400607977, 49344.013119736686, 61237.0, 11527.546532143566, 11611.187216894736, 11721.706957326134, 11733.237339573241, 11874.52501899949, 12907.354632268161, 13216.405261763051, 13241.205527668371, 13391.196528208338, 13408.463661453432, 11316.292367490423, 11381.54473821038, 11401.828972565583, 11457.59898403552, 11508.079353651856, 11556.186101424104, 11857.525698971944, 11859.229150105215, 12053.63839084829, 12259.693507662023, 11032.227744057838, 11172.273802202832, 11368.431578420881, 11565.248258863146, 12099.395030248628, 9547.474888881177, 9802.16681582045, 9884.703458896245, 10130.493475326057, 10250.641227557, 9944.850827237742, 10051.49742512886, 10229.0, 10295.794084118426, 10370.896291036994], "value": 6440.664976082921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 113.0, 117.0, 118.0, 116.0, 118.0, 115.0, 116.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 146.0, 170.0, 128.0, 156.0, 152.0, 127.0, 189.0, 125.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 174.0, 166.0, 164.0, 164.0, 164.0, 165.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 150.0, 77.0, 76.0, 78.0, 75.0, 165.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 140.0, 84.0, 84.0, 85.0, 140.0, 84.0, 86.0, 133.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 64.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 80.0, 78.0, 78.0, 79.0, 88.0, 85.0, 88.0, 84.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 130.0, 140.0, 132.0, 133.0, 131.0, 147.0, 184.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 174.0, 165.0, 172.0, 168.0, 166.0, 169.0, 169.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 73.0, 74.0, 68.0, 73.0, 69.0, 67.0, 67.0, 66.0], "value": 69.3, "unit": "score"}]}]} 05:41:44 INFO - Return code: 0 05:41:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:45 ERROR - # TBPL SUCCESS # 05:41:45 INFO - Running post-action listener: _resource_record_post_action 05:41:45 INFO - ##### 05:41:45 INFO - ##### Finished run-tests step (success) 05:41:45 INFO - ##### 05:41:45 INFO - Running post-run listener: _resource_record_post_run 05:41:45 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 542756864; Read time: 0; Write time: 602684 05:41:45 INFO - TinderboxPrint: CPU usage
13.3% 05:41:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:41:45 INFO - TinderboxPrint: I/O write bytes / time
542,756,864 / 602,684 05:41:45 INFO - TinderboxPrint: CPU idle
8,278.1 (86.7%) 05:41:45 INFO - TinderboxPrint: CPU user
1,218.6 (12.8%) 05:41:45 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245633024; Read time: 0; Write time: 372668 05:41:45 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 296587264; Read time: 0; Write time: 230016 05:41:45 INFO - Running post-run listener: _upload_blobber_files 05:41:45 INFO - Blob upload gear active. 05:41:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:45 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 05:41:45 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:45 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:46 INFO - (blobuploader) - INFO - Done attempting. 05:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:50 INFO - (blobuploader) - INFO - Done attempting. 05:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:50 INFO - (blobuploader) - INFO - Done attempting. 05:41:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:50 INFO - Return code: 0 05:41:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1a64be668b814f6e909a6b81c926dfab81194f68a875a98179a40eadafd91a2e3825ce979c6e1c9c7af705f64d16feda7375a0e4d990310e2905e9e64b9f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02497d4d900fd889e78645d1f16c6803b54c3c678712d6ab283005c9c3d75d237285d8b7267d1f877508dc23cacea870160c2aaf11237337bef10b60616d935e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fdd9fe376ddd32daa216939a5f765b50128f9ec8e597b1dab60437aa6231bb646089473f009f2912d5942c2e7fe2e6474394f64f31b0f2ed3bb3146c816aea"} 05:41:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:50 INFO - Contents: 05:41:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1a64be668b814f6e909a6b81c926dfab81194f68a875a98179a40eadafd91a2e3825ce979c6e1c9c7af705f64d16feda7375a0e4d990310e2905e9e64b9f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02497d4d900fd889e78645d1f16c6803b54c3c678712d6ab283005c9c3d75d237285d8b7267d1f877508dc23cacea870160c2aaf11237337bef10b60616d935e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fdd9fe376ddd32daa216939a5f765b50128f9ec8e597b1dab60437aa6231bb646089473f009f2912d5942c2e7fe2e6474394f64f31b0f2ed3bb3146c816aea"} 05:41:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:50 INFO - Copying logs to upload dir... 05:41:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.042726 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-30 05:41:49.688297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:41:49.691945) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 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/Fx-Team-Non-PGO/sha512/ed1a64be668b814f6e909a6b81c926dfab81194f68a875a98179a40eadafd91a2e3825ce979c6e1c9c7af705f64d16feda7375a0e4d990310e2905e9e64b9f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02497d4d900fd889e78645d1f16c6803b54c3c678712d6ab283005c9c3d75d237285d8b7267d1f877508dc23cacea870160c2aaf11237337bef10b60616d935e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fdd9fe376ddd32daa216939a5f765b50128f9ec8e597b1dab60437aa6231bb646089473f009f2912d5942c2e7fe2e6474394f64f31b0f2ed3bb3146c816aea"} build_url:https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/RqNolv9_TPuLnmor57NL9w/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/Fx-Team-Non-PGO/sha512/ed1a64be668b814f6e909a6b81c926dfab81194f68a875a98179a40eadafd91a2e3825ce979c6e1c9c7af705f64d16feda7375a0e4d990310e2905e9e64b9f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02497d4d900fd889e78645d1f16c6803b54c3c678712d6ab283005c9c3d75d237285d8b7267d1f877508dc23cacea870160c2aaf11237337bef10b60616d935e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fdd9fe376ddd32daa216939a5f765b50128f9ec8e597b1dab60437aa6231bb646089473f009f2912d5942c2e7fe2e6474394f64f31b0f2ed3bb3146c816aea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:41:49.717335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:41:49.717672) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467288500.459389-847671670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:41:49.769692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:41:49.770023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:41:49.770305) ========= ========= Total master_lag: 0.11 =========