builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1467298921.06 results: success (0) buildid: 20160630053005 builduid: c2bf5bf22edc4884a73a0c0d0d810dc0 revision: 7940be96e124a4f6b812d2b3ad6762f2921be04b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.056037) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.056698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.057152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.104283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.104665) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 08:02:01-- 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% 65.7M=0s 2016-06-30 08:02:01 (65.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.231472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.231807) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017658 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.282312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:01.282671) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7940be96e124a4f6b812d2b3ad6762f2921be04b --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 7940be96e124a4f6b812d2b3ad6762f2921be04b --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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 08:02:01,526 truncating revision to first 12 chars 2016-06-30 08:02:01,526 Setting DEBUG logging. 2016-06-30 08:02:01,526 attempt 1/10 2016-06-30 08:02:01,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7940be96e124?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 08:02:01,911 unpacking tar archive at: fx-team-7940be96e124/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:02.173847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:02.174160) ========= script_repo_revision: 7940be96e124a4f6b812d2b3ad6762f2921be04b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:02.174563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:02.174861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 08:02:02.184157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-30 08:02:02.184621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:02:02 INFO - MultiFileLogger online at 20160630 08:02:02 in /builds/slave/test 08:02:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:02:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:02 INFO - {'append_to_log': False, 08:02:02 INFO - 'base_work_dir': '/builds/slave/test', 08:02:02 INFO - 'blob_upload_branch': 'Fx-Team', 08:02:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:02 INFO - 'branch': 'Fx-Team', 08:02:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:02 INFO - 'config_files': ('talos/linux_config.py',), 08:02:02 INFO - 'default_actions': ('clobber', 08:02:02 INFO - 'read-buildbot-config', 08:02:02 INFO - 'download-and-extract', 08:02:02 INFO - 'populate-webroot', 08:02:02 INFO - 'create-virtualenv', 08:02:02 INFO - 'install', 08:02:02 INFO - 'run-tests'), 08:02:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:02 INFO - 'download_minidump_stackwalk': True, 08:02:02 INFO - 'download_symbols': 'ondemand', 08:02:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:02 INFO - 'installer_path': 'installer.exe', 08:02:02 INFO - 'log_level': 'info', 08:02:02 INFO - 'log_name': 'talos', 08:02:02 INFO - 'log_to_console': True, 08:02:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:02:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:02:02 INFO - 'opt_config_files': (), 08:02:02 INFO - 'pip_index': False, 08:02:02 INFO - 'sps_profile': False, 08:02:02 INFO - 'sps_profile_interval': 0, 08:02:02 INFO - 'suite': 'dromaeojs', 08:02:02 INFO - 'system_bits': '32', 08:02:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:02 INFO - 'title': 'talos-linux64-ix-047', 08:02:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:02 INFO - 'use_talos_json': True, 08:02:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:02 INFO - 'work_dir': 'build'} 08:02:02 INFO - ##### 08:02:02 INFO - ##### Running clobber step. 08:02:02 INFO - ##### 08:02:02 INFO - Running pre-action listener: _resource_record_pre_action 08:02:02 INFO - Running main action method: clobber 08:02:02 INFO - rmtree: /builds/slave/test/build 08:02:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:02 INFO - Running post-action listener: _resource_record_post_action 08:02:02 INFO - ##### 08:02:02 INFO - ##### Finished clobber step (success) 08:02:02 INFO - ##### 08:02:02 INFO - ##### 08:02:02 INFO - ##### Running read-buildbot-config step. 08:02:02 INFO - ##### 08:02:02 INFO - Running pre-action listener: _resource_record_pre_action 08:02:02 INFO - Running main action method: read_buildbot_config 08:02:02 INFO - Using buildbot properties: 08:02:02 INFO - { 08:02:02 INFO - "project": "", 08:02:02 INFO - "product": "firefox", 08:02:02 INFO - "script_repo_revision": "production", 08:02:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:02:02 INFO - "repository": "", 08:02:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:02:02 INFO - "buildid": "20160630053005", 08:02:02 INFO - "pgo_build": "True", 08:02:02 INFO - "basedir": "/builds/slave/test", 08:02:02 INFO - "buildnumber": 234, 08:02:02 INFO - "slavename": "talos-linux64-ix-047", 08:02:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:02:02 INFO - "platform": "ubuntu64_hw", 08:02:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:02:02 INFO - "branch": "fx-team", 08:02:02 INFO - "repo_path": "integration/fx-team", 08:02:02 INFO - "revision": "7940be96e124a4f6b812d2b3ad6762f2921be04b", 08:02:02 INFO - "stage_platform": "linux64-pgo", 08:02:02 INFO - "builduid": "c2bf5bf22edc4884a73a0c0d0d810dc0", 08:02:02 INFO - "slavebuilddir": "test" 08:02:02 INFO - } 08:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:02:02 INFO - Running post-action listener: _resource_record_post_action 08:02:02 INFO - ##### 08:02:02 INFO - ##### Finished read-buildbot-config step (success) 08:02:02 INFO - ##### 08:02:02 INFO - ##### 08:02:02 INFO - ##### Running download-and-extract step. 08:02:02 INFO - ##### 08:02:02 INFO - Running pre-action listener: _resource_record_pre_action 08:02:02 INFO - Running main action method: download_and_extract 08:02:02 INFO - mkdir: /builds/slave/test/build/tests 08:02:02 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')]} 08:02:02 INFO - https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:06 INFO - Downloaded 1361 bytes. 08:02:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:02:06 INFO - Using the following test package requirements: 08:02:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:02:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:02:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'jsshell-linux-x86_64.zip'], 08:02:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:02:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:02:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:02:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:02:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:02:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:02:06 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')]} 08:02:06 INFO - https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:02:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:02:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:02:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:10 INFO - Downloaded 24267978 bytes. 08:02:10 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'] 08:02:10 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 08:02:11 INFO - Return code: 0 08:02:11 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 08:02:11 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')]} 08:02:11 INFO - https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:15 INFO - Downloaded 24267978 bytes. 08:02:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:02:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:02:16 INFO - Return code: 0 08:02:16 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')]} 08:02:16 INFO - https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:17 INFO - Downloaded 14405242 bytes. 08:02:17 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'] 08:02:17 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 08:02:18 INFO - Return code: 0 08:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:18 INFO - https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:02:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/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 08:02:20 INFO - Downloaded 60332491 bytes. 08:02:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:20 INFO - mkdir: /builds/slave/test/properties 08:02:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:20 INFO - Contents: 08:02:20 INFO - build_url:https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:21 INFO - Running post-action listener: _resource_record_post_action 08:02:21 INFO - Running post-action listener: set_extra_try_arguments 08:02:21 INFO - ##### 08:02:21 INFO - ##### Finished download-and-extract step (success) 08:02:21 INFO - ##### 08:02:21 INFO - ##### 08:02:21 INFO - ##### Running populate-webroot step. 08:02:21 INFO - ##### 08:02:21 INFO - Running pre-action listener: _resource_record_pre_action 08:02:21 INFO - Running main action method: populate_webroot 08:02:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:21 INFO - '--tppagecycles', 08:02:21 INFO - '7'], 08:02:21 INFO - 'tests': ['tsvgm']}}, 08:02:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['damp', 'tps']}, 08:02:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'tests': ['damp', 'tps']}, 08:02:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['dromaeo_dom']}, 08:02:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['basic_compositor_video']}, 08:02:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['a11yr', 08:02:21 INFO - 'ts_paint', 08:02:21 INFO - 'tpaint', 08:02:21 INFO - 'sessionrestore', 08:02:21 INFO - 'sessionrestore_no_auto_restore', 08:02:21 INFO - 'tabpaint']}, 08:02:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tsvgx', 08:02:21 INFO - 'tsvgr_opacity', 08:02:21 INFO - 'tart', 08:02:21 INFO - 'tscrollx', 08:02:21 INFO - 'cart']}, 08:02:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:21 INFO - 'tsvgr_opacity', 08:02:21 INFO - 'tart', 08:02:21 INFO - 'tscrollx', 08:02:21 INFO - 'cart']}, 08:02:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s'], 08:02:21 INFO - 'tests': ['tp5o']}, 08:02:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'tests': ['tp5o']}, 08:02:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'talos_options': ['--disable-e10s', 08:02:21 INFO - '--xperf_path', 08:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:21 INFO - 'tests': ['tp5n']}, 08:02:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:21 INFO - 'talos_options': ['--xperf_path', 08:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:21 INFO - 'tests': ['tp5n']}}, 08:02:21 INFO - 'talos.zip': {'path': '', 08:02:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:21 INFO - Running post-action listener: _resource_record_post_action 08:02:21 INFO - ##### 08:02:21 INFO - ##### Finished populate-webroot step (success) 08:02:21 INFO - ##### 08:02:21 INFO - ##### 08:02:21 INFO - ##### Running create-virtualenv step. 08:02:21 INFO - ##### 08:02:21 INFO - Running pre-action listener: _resource_record_pre_action 08:02:21 INFO - Running main action method: create_virtualenv 08:02:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:21 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 08:02:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:21 INFO - Using real prefix '/usr' 08:02:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:23 INFO - Installing pip.................done. 08:02:23 INFO - Return code: 0 08:02:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:23 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:23 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 08:02:23 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 08:02:23 INFO - Using env: {'DISPLAY': ':0', 08:02:23 INFO - 'HOME': '/home/cltbld', 08:02:23 INFO - 'LANG': 'en_US.UTF-8', 08:02:23 INFO - 'LANGUAGE': 'en_US:en', 08:02:23 INFO - 'LOGNAME': 'cltbld', 08:02:23 INFO - 'MAIL': '/var/mail/cltbld', 08:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:23 INFO - 'MOZ_NO_REMOTE': '1', 08:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:23 INFO - 'NO_EM_RESTART': '1', 08:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:23 INFO - 'PWD': '/builds/slave/test', 08:02:23 INFO - 'SHELL': '/bin/bash', 08:02:23 INFO - 'SHLVL': '1', 08:02:23 INFO - 'TERM': 'linux', 08:02:23 INFO - 'TMOUT': '86400', 08:02:23 INFO - 'USER': 'cltbld', 08:02:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:23 INFO - '_': '/tools/buildbot/bin/python'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 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 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:24 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 08:02:24 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 08:02:24 INFO - Using env: {'DISPLAY': ':0', 08:02:24 INFO - 'HOME': '/home/cltbld', 08:02:24 INFO - 'LANG': 'en_US.UTF-8', 08:02:24 INFO - 'LANGUAGE': 'en_US:en', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MAIL': '/var/mail/cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SHLVL': '1', 08:02:24 INFO - 'TERM': 'linux', 08:02:24 INFO - 'TMOUT': '86400', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - '_': '/tools/buildbot/bin/python'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 INFO - Downloading/unpacking psutil>=3.1.1 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:26 INFO - Installing collected packages: psutil 08:02:26 INFO - Running setup.py install for psutil 08:02:26 INFO - building 'psutil._psutil_linux' extension 08:02:26 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 08:02:26 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 08:02:26 INFO - building 'psutil._psutil_posix' extension 08:02:26 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 08:02:26 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 08:02:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:26 INFO - Successfully installed psutil 08:02:26 INFO - Cleaning up... 08:02:26 INFO - Return code: 0 08:02:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:26 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')]} 08:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:26 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')]} 08:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:26 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:26 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 08:02:26 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 08:02:26 INFO - Using env: {'DISPLAY': ':0', 08:02:26 INFO - 'HOME': '/home/cltbld', 08:02:26 INFO - 'LANG': 'en_US.UTF-8', 08:02:26 INFO - 'LANGUAGE': 'en_US:en', 08:02:26 INFO - 'LOGNAME': 'cltbld', 08:02:26 INFO - 'MAIL': '/var/mail/cltbld', 08:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:26 INFO - 'MOZ_NO_REMOTE': '1', 08:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:26 INFO - 'NO_EM_RESTART': '1', 08:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:26 INFO - 'PWD': '/builds/slave/test', 08:02:26 INFO - 'SHELL': '/bin/bash', 08:02:26 INFO - 'SHLVL': '1', 08:02:26 INFO - 'TERM': 'linux', 08:02:26 INFO - 'TMOUT': '86400', 08:02:26 INFO - 'USER': 'cltbld', 08:02:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:26 INFO - '_': '/tools/buildbot/bin/python'} 08:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:29 INFO - Installing collected packages: mozsystemmonitor 08:02:29 INFO - Running setup.py install for mozsystemmonitor 08:02:29 INFO - Successfully installed mozsystemmonitor 08:02:29 INFO - Cleaning up... 08:02:29 INFO - Return code: 0 08:02:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:29 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')]} 08:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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')]} 08:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:29 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:29 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 08:02:29 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 08:02:29 INFO - Using env: {'DISPLAY': ':0', 08:02:29 INFO - 'HOME': '/home/cltbld', 08:02:29 INFO - 'LANG': 'en_US.UTF-8', 08:02:29 INFO - 'LANGUAGE': 'en_US:en', 08:02:29 INFO - 'LOGNAME': 'cltbld', 08:02:29 INFO - 'MAIL': '/var/mail/cltbld', 08:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:29 INFO - 'MOZ_NO_REMOTE': '1', 08:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:29 INFO - 'NO_EM_RESTART': '1', 08:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:29 INFO - 'PWD': '/builds/slave/test', 08:02:29 INFO - 'SHELL': '/bin/bash', 08:02:29 INFO - 'SHLVL': '1', 08:02:29 INFO - 'TERM': 'linux', 08:02:29 INFO - 'TMOUT': '86400', 08:02:29 INFO - 'USER': 'cltbld', 08:02:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:29 INFO - '_': '/tools/buildbot/bin/python'} 08:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:31 INFO - warning: no files found matching '*.txt' 08:02:31 INFO - no previously-included directories found matching 'build' 08:02:31 INFO - no previously-included directories found matching 'dist' 08:02:31 INFO - no previously-included directories found matching '.git*' 08:02:31 INFO - Installing collected packages: jsonschema, functools32 08:02:31 INFO - Running setup.py install for functools32 08:02:31 INFO - warning: no files found matching '*.txt' 08:02:31 INFO - no previously-included directories found matching 'build' 08:02:31 INFO - no previously-included directories found matching 'dist' 08:02:31 INFO - no previously-included directories found matching '.git*' 08:02:31 INFO - Successfully installed jsonschema functools32 08:02:31 INFO - Cleaning up... 08:02:31 INFO - Return code: 0 08:02:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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', '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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:02: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 blobuploader==1.2.4 08:02:31 INFO - Using env: {'DISPLAY': ':0', 08:02:31 INFO - 'HOME': '/home/cltbld', 08:02:31 INFO - 'LANG': 'en_US.UTF-8', 08:02:31 INFO - 'LANGUAGE': 'en_US:en', 08:02:31 INFO - 'LOGNAME': 'cltbld', 08:02:31 INFO - 'MAIL': '/var/mail/cltbld', 08:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:31 INFO - 'MOZ_NO_REMOTE': '1', 08:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:31 INFO - 'NO_EM_RESTART': '1', 08:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:31 INFO - 'PWD': '/builds/slave/test', 08:02:31 INFO - 'SHELL': '/bin/bash', 08:02:31 INFO - 'SHLVL': '1', 08:02:31 INFO - 'TERM': 'linux', 08:02:31 INFO - 'TMOUT': '86400', 08:02:31 INFO - 'USER': 'cltbld', 08:02:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:31 INFO - '_': '/tools/buildbot/bin/python'} 08:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:34 INFO - Downloading docopt-0.6.1.tar.gz 08:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:34 INFO - Running setup.py install for blobuploader 08:02:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:34 INFO - Running setup.py install for requests 08:02:35 INFO - Running setup.py install for docopt 08:02:35 INFO - Successfully installed blobuploader requests docopt 08:02:35 INFO - Cleaning up... 08:02:35 INFO - Return code: 0 08:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:35 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:35 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 08:02:35 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 08:02:35 INFO - Using env: {'DISPLAY': ':0', 08:02:35 INFO - 'HOME': '/home/cltbld', 08:02:35 INFO - 'LANG': 'en_US.UTF-8', 08:02:35 INFO - 'LANGUAGE': 'en_US:en', 08:02:35 INFO - 'LOGNAME': 'cltbld', 08:02:35 INFO - 'MAIL': '/var/mail/cltbld', 08:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:35 INFO - 'MOZ_NO_REMOTE': '1', 08:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:35 INFO - 'NO_EM_RESTART': '1', 08:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:35 INFO - 'PWD': '/builds/slave/test', 08:02:35 INFO - 'SHELL': '/bin/bash', 08:02:35 INFO - 'SHLVL': '1', 08:02:35 INFO - 'TERM': 'linux', 08:02:35 INFO - 'TMOUT': '86400', 08:02:35 INFO - 'USER': 'cltbld', 08:02:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:35 INFO - '_': '/tools/buildbot/bin/python'} 08:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:35 INFO - Running setup.py (path:/tmp/pip-FDXrfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:35 INFO - Running setup.py (path:/tmp/pip-7Mp_VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:35 INFO - Running setup.py (path:/tmp/pip-mJZYMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:35 INFO - Running setup.py (path:/tmp/pip-DRyLEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:35 INFO - Running setup.py (path:/tmp/pip-2haaKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:35 INFO - Running setup.py (path:/tmp/pip-xePjuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:35 INFO - Running setup.py (path:/tmp/pip-MbtRRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:35 INFO - Running setup.py (path:/tmp/pip-5aXOMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:36 INFO - Running setup.py (path:/tmp/pip-lvx0CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:36 INFO - Running setup.py (path:/tmp/pip-FBQiop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:36 INFO - Running setup.py (path:/tmp/pip-F1tLop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:36 INFO - Running setup.py (path:/tmp/pip-TOYsab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:36 INFO - Running setup.py (path:/tmp/pip-i9CB42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:36 INFO - Running setup.py (path:/tmp/pip-UgPrlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:36 INFO - Running setup.py (path:/tmp/pip-uCnrtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:36 INFO - Running setup.py (path:/tmp/pip-Wi3R8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:36 INFO - Running setup.py (path:/tmp/pip-zNL_vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:36 INFO - Running setup.py install for manifestparser 08:02:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozcrash 08:02:36 INFO - Running setup.py install for mozdebug 08:02:36 INFO - Running setup.py install for mozdevice 08:02:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozfile 08:02:37 INFO - Running setup.py install for mozhttpd 08:02:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozinfo 08:02:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozInstall 08:02:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozleak 08:02:37 INFO - Running setup.py install for mozlog 08:02:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for moznetwork 08:02:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Running setup.py install for mozprocess 08:02:37 INFO - Running setup.py install for mozprofile 08:02:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozrunner 08:02:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozscreenshot 08:02:38 INFO - Running setup.py install for moztest 08:02:38 INFO - Running setup.py install for mozversion 08:02:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:38 INFO - Cleaning up... 08:02:38 INFO - Return code: 0 08:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:38 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:38 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 08:02:38 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 08:02:38 INFO - Using env: {'DISPLAY': ':0', 08:02:38 INFO - 'HOME': '/home/cltbld', 08:02:38 INFO - 'LANG': 'en_US.UTF-8', 08:02:38 INFO - 'LANGUAGE': 'en_US:en', 08:02:38 INFO - 'LOGNAME': 'cltbld', 08:02:38 INFO - 'MAIL': '/var/mail/cltbld', 08:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:38 INFO - 'MOZ_NO_REMOTE': '1', 08:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:38 INFO - 'NO_EM_RESTART': '1', 08:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:38 INFO - 'PWD': '/builds/slave/test', 08:02:38 INFO - 'SHELL': '/bin/bash', 08:02:38 INFO - 'SHLVL': '1', 08:02:38 INFO - 'TERM': 'linux', 08:02:38 INFO - 'TMOUT': '86400', 08:02:38 INFO - 'USER': 'cltbld', 08:02:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:38 INFO - '_': '/tools/buildbot/bin/python'} 08:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:38 INFO - Running setup.py (path:/tmp/pip-8XUWZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:38 INFO - Running setup.py (path:/tmp/pip-ifV3fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:38 INFO - Running setup.py (path:/tmp/pip-advVkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:38 INFO - Running setup.py (path:/tmp/pip-3nvinP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:38 INFO - Running setup.py (path:/tmp/pip-cmUeh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:39 INFO - Running setup.py (path:/tmp/pip-3CAW_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:39 INFO - Running setup.py (path:/tmp/pip-1Li_D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:39 INFO - Running setup.py (path:/tmp/pip-8purx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:39 INFO - Running setup.py (path:/tmp/pip-Ledb0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:39 INFO - Running setup.py (path:/tmp/pip-gb8cMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:39 INFO - Running setup.py (path:/tmp/pip-I9PyYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:39 INFO - Running setup.py (path:/tmp/pip-oRd8Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:39 INFO - Running setup.py (path:/tmp/pip-Tl1Um1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:39 INFO - Running setup.py (path:/tmp/pip-1m1x0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:39 INFO - Running setup.py (path:/tmp/pip-GB2sP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:39 INFO - Running setup.py (path:/tmp/pip-lIuTLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:39 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)) 08:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:39 INFO - Running setup.py (path:/tmp/pip-gvpdYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:39 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)) 08:02:39 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)) 08:02:39 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)) 08:02:39 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)) 08:02:39 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)) 08:02:39 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)) 08:02:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:41 INFO - Downloading blessings-1.6.tar.gz 08:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:41 INFO - Installing collected packages: blessings 08:02:41 INFO - Running setup.py install for blessings 08:02:41 INFO - Successfully installed blessings 08:02:41 INFO - Cleaning up... 08:02:42 INFO - Return code: 0 08:02:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:42 INFO - Reading from file tmpfile_stdout 08:02:42 INFO - Current package versions: 08:02:42 INFO - argparse == 1.2.1 08:02:42 INFO - blessings == 1.6 08:02:42 INFO - blobuploader == 1.2.4 08:02:42 INFO - docopt == 0.6.1 08:02:42 INFO - functools32 == 3.2.3-2 08:02:42 INFO - jsonschema == 2.5.1 08:02:42 INFO - manifestparser == 1.1 08:02:42 INFO - mozInstall == 1.12 08:02:42 INFO - mozcrash == 0.17 08:02:42 INFO - mozdebug == 0.1 08:02:42 INFO - mozdevice == 0.48 08:02:42 INFO - mozfile == 1.2 08:02:42 INFO - mozhttpd == 0.7 08:02:42 INFO - mozinfo == 0.9 08:02:42 INFO - mozleak == 0.1 08:02:42 INFO - mozlog == 3.2 08:02:42 INFO - moznetwork == 0.27 08:02:42 INFO - mozprocess == 0.22 08:02:42 INFO - mozprofile == 0.28 08:02:42 INFO - mozrunner == 6.11 08:02:42 INFO - mozscreenshot == 0.1 08:02:42 INFO - mozsystemmonitor == 0.3 08:02:42 INFO - moztest == 0.7 08:02:42 INFO - mozversion == 1.4 08:02:42 INFO - psutil == 3.1.1 08:02:42 INFO - requests == 1.2.3 08:02:42 INFO - wsgiref == 0.1.2 08:02:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:42 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 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:42 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 08:02:42 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 08:02:42 INFO - Using env: {'DISPLAY': ':0', 08:02:42 INFO - 'HOME': '/home/cltbld', 08:02:42 INFO - 'LANG': 'en_US.UTF-8', 08:02:42 INFO - 'LANGUAGE': 'en_US:en', 08:02:42 INFO - 'LOGNAME': 'cltbld', 08:02:42 INFO - 'MAIL': '/var/mail/cltbld', 08:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:42 INFO - 'MOZ_NO_REMOTE': '1', 08:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:42 INFO - 'NO_EM_RESTART': '1', 08:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:42 INFO - 'PWD': '/builds/slave/test', 08:02:42 INFO - 'SHELL': '/bin/bash', 08:02:42 INFO - 'SHLVL': '1', 08:02:42 INFO - 'TERM': 'linux', 08:02:42 INFO - 'TMOUT': '86400', 08:02:42 INFO - 'USER': 'cltbld', 08:02:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:42 INFO - '_': '/tools/buildbot/bin/python'} 08:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 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)) 08:02:42 INFO - Cleaning up... 08:02:42 INFO - Return code: 0 08:02:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', '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 08:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:02:42 INFO - Using env: {'DISPLAY': ':0', 08:02:42 INFO - 'HOME': '/home/cltbld', 08:02:42 INFO - 'LANG': 'en_US.UTF-8', 08:02:42 INFO - 'LANGUAGE': 'en_US:en', 08:02:42 INFO - 'LOGNAME': 'cltbld', 08:02:42 INFO - 'MAIL': '/var/mail/cltbld', 08:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:42 INFO - 'MOZ_NO_REMOTE': '1', 08:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:42 INFO - 'NO_EM_RESTART': '1', 08:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:42 INFO - 'PWD': '/builds/slave/test', 08:02:42 INFO - 'SHELL': '/bin/bash', 08:02:42 INFO - 'SHLVL': '1', 08:02:42 INFO - 'TERM': 'linux', 08:02:42 INFO - 'TMOUT': '86400', 08:02:42 INFO - 'USER': 'cltbld', 08:02:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:42 INFO - '_': '/tools/buildbot/bin/python'} 08:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:42 INFO - Cleaning up... 08:02:42 INFO - Return code: 0 08:02:42 INFO - Running post-action listener: _resource_record_post_action 08:02:42 INFO - Running post-action listener: _start_resource_monitoring 08:02:42 INFO - Starting resource monitoring. 08:02:42 INFO - ##### 08:02:42 INFO - ##### Finished create-virtualenv step (success) 08:02:42 INFO - ##### 08:02:42 INFO - ##### 08:02:42 INFO - ##### Running install step. 08:02:42 INFO - ##### 08:02:42 INFO - Running pre-action listener: _resource_record_pre_action 08:02:42 INFO - Running main action method: install 08:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:42 INFO - Reading from file tmpfile_stdout 08:02:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:43 INFO - Reading from file tmpfile_stdout 08:02:43 INFO - Output received: 08:02:43 INFO - Usage: mozinstall [options] installer 08:02:43 INFO - Options: 08:02:43 INFO - -h, --help show this help message and exit 08:02:43 INFO - -d DEST, --destination=DEST 08:02:43 INFO - Directory to install application into. [default: 08:02:43 INFO - "/builds/slave/test"] 08:02:43 INFO - --app=APP Application being installed. [default: firefox] 08:02:43 INFO - mkdir: /builds/slave/test/build/application 08:02:43 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'] 08:02:43 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 08:03:00 INFO - Reading from file tmpfile_stdout 08:03:00 INFO - Output received: 08:03:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:03:00 INFO - Running post-action listener: _resource_record_post_action 08:03:00 INFO - ##### 08:03:00 INFO - ##### Finished install step (success) 08:03:00 INFO - ##### 08:03:00 INFO - ##### 08:03:00 INFO - ##### Running run-tests step. 08:03:00 INFO - ##### 08:03:00 INFO - Running pre-action listener: _resource_record_pre_action 08:03:00 INFO - Running main action method: run_tests 08:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:00 INFO - Python 2.7.3 08:03:00 INFO - Return code: 0 08:03:00 INFO - grabbing minidump binary from tooltool 08:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:00 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 0x10ec3b0>, '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 0x10ed2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:00 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 08:03:00 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 08:03:00 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 08:03:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:00 INFO - Return code: 0 08:03:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:03:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:03:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:03:00 INFO - Using env: {'DISPLAY': ':0', 08:03:00 INFO - 'HOME': '/home/cltbld', 08:03:00 INFO - 'LANG': 'en_US.UTF-8', 08:03:00 INFO - 'LANGUAGE': 'en_US:en', 08:03:00 INFO - 'LOGNAME': 'cltbld', 08:03:00 INFO - 'MAIL': '/var/mail/cltbld', 08:03:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:00 INFO - 'MOZ_NO_REMOTE': '1', 08:03:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:00 INFO - 'NO_EM_RESTART': '1', 08:03:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:00 INFO - 'PWD': '/builds/slave/test', 08:03:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:00 INFO - 'SHELL': '/bin/bash', 08:03:00 INFO - 'SHLVL': '1', 08:03:00 INFO - 'TERM': 'linux', 08:03:00 INFO - 'TMOUT': '86400', 08:03:00 INFO - 'USER': 'cltbld', 08:03:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928', 08:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:00 INFO - '_': '/tools/buildbot/bin/python'} 08:03:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:03:00 INFO - mozversion application_buildid: 20160630053005 08:03:00 INFO - mozversion application_changeset: 7940be96e124a4f6b812d2b3ad6762f2921be04b 08:03:00 INFO - mozversion application_display_name: Nightly 08:03:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:00 INFO - mozversion application_name: Firefox 08:03:00 INFO - mozversion application_remotingname: firefox 08:03:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:03:00 INFO - mozversion application_vendor: Mozilla 08:03:00 INFO - mozversion application_version: 50.0a1 08:03:00 INFO - mozversion platform_buildid: 20160630053005 08:03:00 INFO - mozversion platform_changeset: 7940be96e124a4f6b812d2b3ad6762f2921be04b 08:03:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:03:00 INFO - mozversion platform_version: 50.0a1 08:03:00 INFO - using testdate: 1467298980 08:03:00 INFO - actual date: 1467298980 08:03:00 INFO - starting webserver on 'localhost:34817' 08:03:00 INFO - SUITE-START | Running 2 tests 08:03:00 INFO - TEST-START | dromaeo_css 08:03:00 INFO - operating with platform_type : linux_ 08:03:00 INFO - Initialising browser for dromaeo_css test... 08:03:00 INFO - TEST-INFO | started process 25043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJc5tn/profile http://localhost:34817/getInfo.html) 08:03:04 INFO - PROCESS | 25043 | __metrics Screen width/height:1600/1200 08:03:04 INFO - PROCESS | 25043 | colorDepth:24 08:03:04 INFO - PROCESS | 25043 | Browser inner width/height: 1024/697 08:03:04 INFO - PROCESS | 25043 | __metrics 08:03:05 INFO - PROCESS | 25043 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:06 INFO - TEST-INFO | 25043: exit 0 08:03:06 INFO - Browser initialized. 08:03:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:06 INFO - TEST-INFO | started process 25125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJc5tn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:18 INFO - PROCESS | 25125 | RSS: Main: 157380608 08:03:18 INFO - PROCESS | 25125 | 08:04:09 INFO - PROCESS | 25125 | 1467299049779 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] 08:06:17 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34817/tests/dromaeo/cssquery-ext.html) 08:06:18 INFO - PROCESS | 25125 | RSS: Main: 269754368 08:06:18 INFO - PROCESS | 25125 | 08:09:21 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-ext.html (next: http://localhost:34817/tests/dromaeo/cssquery-jquery.html) 08:09:21 INFO - PROCESS | 25125 | RSS: Main: 245239808 08:09:21 INFO - PROCESS | 25125 | 08:12:23 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34817/tests/dromaeo/cssquery-mootools.html) 08:12:24 INFO - PROCESS | 25125 | RSS: Main: 249966592 08:12:24 INFO - PROCESS | 25125 | 08:15:26 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34817/tests/dromaeo/cssquery-prototype.html) 08:15:27 INFO - PROCESS | 25125 | RSS: Main: 236732416 08:15:27 INFO - PROCESS | 25125 | 08:18:29 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34817/tests/dromaeo/cssquery-yui.html) 08:18:30 INFO - PROCESS | 25125 | RSS: Main: 228696064 08:18:30 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-yui.html (next: http://localhost:34817/tests/dromaeo/cssquery-dojo.html) 08:21:33 INFO - PROCESS | 25125 | RSS: Main: 293396480 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | __start_tp_report 08:21:33 INFO - PROCESS | 25125 | _x_x_mozilla_page_load 08:21:33 INFO - PROCESS | 25125 | _x_x_mozilla_page_load_details 08:21:33 INFO - PROCESS | 25125 | |i|pagename|runs| 08:21:33 INFO - PROCESS | 25125 | |0;dojo.html;3092.0569226385956;3119.313750974785;3125.078101959921;3152.5113607390836;3178.5550022996786;5178.249153872695;5273.235380869781;5344.599155063372;5424.484673955978;5454.045542030139;5317.255584218213;5343.385510666275;5346.732663366835;5399.1091469907515;5408.621396502246;4784.832530861429;4879.170541008037;4881.316615673791;4902.264660300948;5034.42104158021;4948.752562371867;4978.327925730016;4991.7504124793795;5004.349434573501;5042.268871013701;4775.283707443877;4803.9039219215765;4830.178869592142;4833.226683730604;4907.779149938261;4808.951910480885;4816.51834816519;4819.590334821544;4893.559579637814;4961.652684312099;4837.879053023703;4869.245266983623;4869.805207791719;4887.608991280689;4901;5138.409082955471;5277.788888444457;5347.919781203285;5349.251104845324;5358.517733404013;5771.336296325934;5820.214271073393;5828.825135245949;5829.854253643693;5831.795887143972;5817.447342502455;5845.503132233765;5866.325372582165;5866.794662186803;5872.618279811799;5237.083510385705;5262.55268302191;5297.311349524537;5304.73476326186;5454.10007348787;5819.970900145472;5870.765169393262;5881.911771323434;5882.55880808941;5883.764649413975;5594;5595.328560572757;5636;5649.096144616841;5651.208830763697;5521.585881058937;5638.295213098363;5689.886202275931;5697.971510142423;5778.479936805707;5720.799772007959;5720.971395142998;5726.226959360433;5730.455606717355;5763.077907534775;5666.801661941812;5699.202111704365;5706.572007099484;5715.371309155989;5717.456841600041;4280.486341638961;4285.97857010713;4330.805113769888;4377.365282034088;4389.6927215095275;3828.349180639242;3836.731428800013;3848.230353929225;3894.3963685628773;3918.3338832398563;5369.731513424314;5378.97310513445;5393.83818485446;5399.946000539944;5412.431694672082;5725.370209277059;5730.312362516442;5731.111677689964;5734.139879018181;5767.8558036049435;5286.920696189561;5356.758945847446;5365.517103460707;5388.46115388458;5423.538999185034;4947.307376967227;4949.307097006422;4953.18272485036;4953.876153096201;4969.776360063805;5653.010723123437;5846.824595262149;5863.120531920246;5864.413558644102;5866.70666466675;5613.270274864241;5665.801696940587;5675.7445914933105;5679.858003549944;5706.572007099568;5799.82600521985;5802.564807639359;5807.477327040587;5814.30228372598;5816.127580862904;5513.145462453326;5523.447655234444;5573.470520300727;5585.162225666182;5587.106063029895;5673.716314184357;5684.8294551163535;5723.456271654186;5726.341470730919;5783.161441590862;5562.499375056264;5572.86067848307;5574.275344205227;5577.470140336662;5578.163275508706;5421.945780542144;5524.779008839601;5545.417731138334;5558.055130627722;5560.165975103767;5519.061759500814;5522;5528.06022976087;5529.198266251291;5575.2473416088305;5627.606067575231;5637.49262566371;5642.943570564242;5643.548516118783;5696.686682232517;5385.2999110117;5396.325459317585;5441.673499590037;5475.780968761205;5512.476314750093 08:21:33 INFO - PROCESS | 25125 | |1;ext.html;594.8275000249928;623.5043140703141;627.5262177056319;627.6391075131801;645.0839807473387;30554.847225763868;43389.56610433895;43937.7803110984;44030;44089.11821763563;45598.77200613992;45871;46019.30971035437;46090.53909460904;46154.769226153905;8986.2810975122;9119.49842758648;9133;9140.085991400872;9146.405483643575;8969.820603587925;9043.547822608876;9059.637614495412;9081.137291957253;9089.136532029446;9063.184313411792;9098.86351704725;9106.726798196065;9111.316651251183;9114.680986165486;9044.502552359618;9062;9072.591733372014;9081.45511269326;9099.226565741952;8918.509481978488;9023.81952360949;9026.729198124067;9028.097190280985;9033.864492032559;44084.779576102235;44384.55615443837;44469.332960005624;44486.33270500945;44489;3355.6644335566493;3370.679785420381;3404.8127352995575;3477.565304336958;3504.1590018395655;33147.33705325904;33411.16472088193;33476.1630959228;34028.6597134028;34721.30557388838;4342.6742994275555;4382.868513944587;4395.648348132142;4405.405270288502;4516.20966330894;255520;255756;256099.1950402491;256278;256337;57580.42419575834;58865;59158;59268.40731592629;59328.40671593315;63226;64297.357026429134;64566;70802.2919770806;70930;17126.743098853527;17279.827201728072;17372.913135434243;17408.129593520272;17418.65162696739;11282.435878206057;11460.369679667698;13245.403956821967;13371.130876492996;13372.197668139943;16451.25969331383;18312.725309120375;18703.971281579645;18720.157592908352;19309.806901930802;6624.940009598441;6739.449926516831;6867.141607299088;6938.722451101899;6952.5480843745;919.287552147078;1051.3324039234988;1100.8954149355798;1105.0275757333495;1180.740237147826;30872.84563577168;31390.843045784626;31396.215094622818;31788;31928;1101.911847052234;1126.4987080749152;1154.6362895687998;1191.362620997762;1212.1333246728454;16890.239939202766;16902;16945.915270423815;16950.23723932426;17052.573685657957;153181;153473;154752;154831;155020;58806.41193588095;60009.399906000384;60121.398786012454;60148.39851601428;60180.39819601835;1252.1047451072527;1332.1274565159836;1373.9106958047696;1374.1411617739113;1380.3995262061035;31685;33781.324373512885;34093;34424.99313238229;34536;51462.74268628633;51490;51989;52098.47901520936;52297;422844;424960;425064;425431;425598;35792.28415431625;44228;44853.32720009268;45329.546704532535;45547.77226113848;45035.09929801451;46166.53833461623;49344.75327623339;49524.50475495199;50363.74818125886;40519.189616206924;41314.380284295155;41840.1631967365;41991;42430.57569424266;40293.59706402898;40429;40986.1802763949;41431.58568414398;41621;41111.38332925068;41449.171016580105;42437.78781106075;42658.360124598774;42672.78663606662;35853;36396.27207455889;36499.817500913385;36837.44743828898;37157.25685486221;26365;26496.337591560365;26583.867080664473;26646.928934261377;26779.866100669373 08:21:33 INFO - PROCESS | 25125 | |2;jquery.html;403.39087977154486;404.5691338724258;411.82085792680175;414.3122416788131;427.06259759827174;19296.131674074666;19774.604507909833;20227.292044778435;20598.1760729571;20630.48423789406;18023;18109.1850866711;18556;18727.25090996362;18902.43292701221;5090.10923088459;5424.349078110632;5458.181272809071;5466.863328416782;5469.316335458067;3925.862594809182;5323.148296272597;5344.22508736233;5701.8026214495;5954.9404505955035;6054.788082417116;6056.666883321415;6074.63552186868;6076.301225359096;6081.78713745019;5981.005860106816;6420.871582568369;6576.835579110512;6641.169853768279;6669.032990216416;3845.2309538092495;5514.531264842493;5805.245318108661;5858.941410585882;5864.70676466175;14823.18472484013;14961.551153465414;14985.475508357154;15064.096154230781;15064.472743454036;2328.988355058231;2364.1725396111397;2419.818513611486;2440.5240978009297;2979.6275465566805;10687.251892367538;13505.324733763273;14794.482193123189;15311.928165028341;15473;1957;2032.8068833460798;2040.4221494757776;2045.3659365596714;2116.9576608467746;85343;85365.57317213374;86228.13771862263;86931.13068869356;86971.56514217451;11058.723531911766;11365.431728413547;11526.59656912004;11669.99999999983;11753.471093800628;16149.111798850941;16324.591885202964;16364.427245046367;16389.344426223055;16400;8326.6669333226;8512.552866012793;8557.400981931329;8657.653693852302;8663.176998185163;8182.959085204536;8184.468009579358;8199.590020498952;8319.8336033279;8341.749747507585;5027.874303142377;5047.192449208183;5059.924101138412;5141.100307446182;5187.792488300502;1815.9770488894117;1940.1172466527696;2000.8099230573073;2045.457953642286;2099.6745504446835;914.7255823252998;964.392432767352;982.5234761140841;1025.5333823110466;1043.780806030742;18669.159887805083;19066.809331906505;19282.90358548198;19437.22251109968;19451.12469938856;949.5726922884592;1003.4079892863246;1006.6728313298207;1008.2337423558149;1058.5765693722572;10746.892531074589;10996.395198264172;10999;10999.065079468175;11071.501782419811;487618;495118;495813;498163;518331;86816.56591717128;89542;89933;90152.54923725339;90941;996.6611352140162;1002.1281485108003;1002.8896821349646;1007.4308015970953;1013.2248829645474;17611.20749566247;17686;17782.644347112728;17990.37033703814;18284.268629255213;41728;42207.788961055;42682.1463570733;42946.78526607347;43187;54899.72550137224;55911.720441397534;58350;65509.34490655032;66522;8994.50530220818;9004.41471304363;9243.537823108683;9386.014468480984;11441.656750297505;13849.515266966011;14222.431102755774;14748;14954.102753834804;14954.626134346729;12787.87212127904;12911.612651620466;12945;13116.213027218397;13231.470741170246;12395.008399328213;12666.936665316614;12765;12894.355282236038;12963.611091667264;13176.73646527045;13230.603081907559;13242.735145297233;13353.596352656616;13434.865651343362;13171.2755798432;13174.341282936006;13198.868011319764;13267.66830829237;13275.800862987257;12853.421596028014;13070.80393794075;13085.214887106804;13092.345382731015;13166.605001849959 08:21:33 INFO - PROCESS | 25125 | |3;mootools.html;1314.7370525894823;1460.2479722942687;1481.9851801481984;1622.69168857917;1765.5056584156432;8028.116907140217;8395.496270223783;8430.409871309012;8599.35504837138;8599.95700021499;8517.701880434186;8726.345524085687;8731.25784308333;8732.607032683529;8739.694110706127;2079.979200208001;2266.5920134375806;2348.6242201247805;2371.3241726108063;2396.2451827674226;2361.9409514762096;2363.267387109993;2368.9644655330185;2377.2274010946426;2379.8334116611845;2359.3629719975597;2376.310869847742;2387.2957477544164;2388.0447820871705;2389.080204121417;2042.1525067097136;2244.7867452591977;2330.93007209784;2338.0647740903605;2351.259353303704;2329.7670232976734;2333.300009996994;2346.4133966508375;2347.5657003454417;2353.035255545218;8815.118488151198;8863.069377715376;8876.245519130882;8878.644854205824;8889.73330800077;5036.622253330978;5071.7210553419545;5080.898382032376;5113.718745468997;5116.616253780944;3458.6714262145056;3540.8760693375607;3601.3157500075163;3601.58581763098;3644.908877278063;1185.6324539392815;1212.9029677625856;1214.283572692116;1236.048242852998;1240.7332423528985;12129.939350303192;12164.08769342303;12170.026397888148;12251.448684809206;12264.632061038183;4385.210662080793;4483.349914262414;4624.815007399734;4664.416947881515;4670.859874203779;10230.437325947145;10242.897571024343;10246.436445995541;10253.282270241012;10254.794904101876;5181.844544663666;5203.843884683465;5208.427073021964;5211.009908117521;5215.504527069922;4296.742195468282;4345.97827010863;4413.492448368414;4416.53626369233;4469.508354081048;4115.300398932189;4118.691098167649;4132.297509423405;4137.172565486914;4180.958190418118;1219.634109767084;1298.3767791460152;1329.8098202109252;1361.5915225432332;1371.1156304183746;832.7168762620738;961.3558915526474;965.1554889471712;971.582219645545;975.9609615615295;5815.534757219497;5895.204147440127;5928.555358348141;6113.96943015291;6140.324564297924;917.1928702741545;944.2398868910593;948.3551185194134;965.1169180200038;984.3306551544875;3991.8802435926386;4080.449139366207;4087.8773636790943;4109.568495308009;4119.423280740699;10563.524641391155;11027.44862756859;11051;11053.668389948314;11064.778704425866;10808.189385796097;10920.18098642605;10928.289661172157;10941.617043403443;10964.17768667353;8209.58952052395;8360.790980225422;8362.749117526484;8365.414420990593;8369.163083691705;5737.340205876378;5809.070548712186;5894.764209431746;6001.159837622824;6064.332923378337;9578.473183974947;10183.898161018295;10244.692659220234;10249.795004099728;10256.230782691178;10054.095131438205;10246.487675616338;10357.119644829972;10362.171026317727;10375.014373634493;7690.115636701851;7778.649960751666;7857.528548287121;7871;7951.761447156595;8293.460925039853;8393.202645748644;8442.113578074213;8446.831063378575;8460.153984601737;7387.519811212254;7651.885221721567;7658.310752032344;7717.768466946;7779.92220077792;7472.439567032603;7558;7599.734009309869;7657.234276572521;7673.194314596887;7072.186698529529;7108.715651373887;7140.07179066718;7140.214576396488;7143.785686429415;5136.871578210575;5235.3717553893775;5320.627556071038;5379.946200537945;5403.270558474555;5202.375714914083;5211.00078065564;5231.476852314738;5275.182346736262;5485.0949593318255 08:21:33 INFO - PROCESS | 25125 | |4;prototype.html;325.9745076223381;340.6814628322518;340.7035878785457;344.81207741780725;348.3694512931594;5128.282040514322;5264.631475796696;5275.31420915281;5330.413654498002;5366.517013468787;5279.155335146377;5296.788128474866;5300.708461034642;5310.867228319294;5316.813911513098;4090.6727461803134;4154.543000269968;4167;4202.264603694357;4214.831406743727;3988.1824226033737;4004.0790618157694;4159.521655009682;4179.498460184767;4192.916141677165;4167.458230430055;4187.246295666779;4190.895227619319;4197.580241975793;4198.475190601175;4164.625183733463;4178.707490475653;4198.13938142683;4211.873643790691;4219.493660760729;3641.563012438498;3684.8395879724276;3726.5341832270965;3755.7370984031127;3767.1147280389087;5143.202803565453;5165.708572856785;5169.922451163236;5174.4825517448335;5174.663646862942;4799.592034677056;4802.351682522884;4813.590844778198;4834.927476087862;4838.177509823338;5374.758135883894;5502.752376143083;5520.806771763009;5531.115021596565;5577.69322687252;4043.7262262387253;4072.1448495815916;4093.263212621727;4096.303628383182;4098.815553300109;5707.77168913243;5729.255196824386;5733.971330143323;5738.885222295572;5770.596058275923;4089.8364065437645;4219.409282700424;4221.197972385237;4229.407882896336;4236.406903033578;4262.808173632194;4283.507396649363;4284.250256205151;4285;4295.634871035934;4811.5805837278085;4829.589484893823;4852.660313778072;4854.927176092361;4870.512948705101;5254.395744489356;5565.638233514808;5578.30271216098;5583.581231407661;5626.127950167731;1353.5871559174545;1396.2599822094305;1415.8796502297214;1436.7988481612583;1440.4958264607303;975.4829940131741;988.5502096546054;998.9500524973722;1004.7940172264668;1008.2337423558002;5328.973355133277;5331.680099194061;5350.946490535045;5352.732363381893;5363.383210930715;5653.858653533613;5658.490735833795;5658.632188907708;5659.349174844863;5669.376368599451;5153.458886816905;5281.339832520935;5283.1546952487415;5352.116900711339;5386.67679939197;2649.4436168404463;2666.7733242674203;2668.2795645175693;2671.5324818156746;2676.3175390275355;5104.702883702349;5115.897682046339;5117.155669314596;5122.743862806919;5124.641275110706;4785.832495862698;5116.309298244763;5118.87566659832;5133.79464821403;5137.537621614073;5061.367329083864;5065.35376002808;5083.415407228216;5090.974545127251;5115.7953681852305;4935.975320123376;4974.925376119433;4982.526659967298;5043.672161309503;5043.722595257296;4709.670323077352;4916.950830491793;4948.529889660476;4967.279744436964;4969.503049695146;5099.286099945936;5110.437851836221;5116.283720279238;5124.948750512447;5130.895808036084;3728.8881333560034;3743.8502459901297;3746.662800347982;3759.3984962405884;3766.2844059628583;4710.7859306126065;4984.22744474607;4997.85006449807;5429.5656347492895;5579.246801681721;5345.839624811262;5410.891782164414;5423.511883930465;5436.565074794086;5537.5569954402745;5512.80705175317;5519.399374181442;5520.957245819072;5551.25058117149;5580.581456390706;5266.2363957225225;5462.726863656881;5464.131331051071;5473.863153421196;5491.862703432446;5509.696966666872;5538.529225015919;5540.307461567304;5542.8337149885565;5575.745457272082;5321.893562128658;5396.379416367168;5425.810096646598;5452.454754524516;5482.588805839658 08:21:33 INFO - PROCESS | 25125 | |5;yui.html;827.2058823529416;843.4348986179259;848.3415617829079;875.3216257400513;885.481993034075;13334.66663333416;14236.359363828627;14280.357383917722;14280.642983925407;14311.284435778209;13484.797728034062;14342.13947163171;14426.35081421336;14455.060421072649;14455.277236138203;676.5703778100892;793.8015496125969;799.0331698644646;799.6441583495347;804.5775967616989;797.2824457987799;822.0053734980651;822.0628483528782;823.1357075071181;832.3923535818856;830.5307501261768;837;838.0488145954355;839.7564706235185;848.1264297773304;697.3201128899333;718.3463048625725;833.6207025803245;834.9813227861998;836.4939211776879;524.5331654827207;609.402785270433;618.3630860213987;620.9410106039919;626.3861415812484;13002.544910928073;13049.673758156026;13106.148100373444;13131;13138.540151094665;14450.783238251435;14839.703205935928;14865.628359290997;15069.09585424878;15082.396704131932;13140.157042596033;13318.40626936689;13327.133736307205;13380.397882095329;13559.118657287245;4518.231900576877;4618.099470603233;4637.791299391535;4671.439427268716;4735.976320118378;71113.93329100119;71235.28764712339;71884;71956;72072.639636802;11632.825507617392;11647.184697071123;11686.357250351142;11692.35692036946;11987.640370788717;20745.89627051855;20898.895505522374;20912.790872091387;20925.89537052305;20946.057427415803;8732.65069397217;8735.781605459915;8746.518941458153;8755.956220218986;8921.509316987627;4825.689348730523;4939.925901111486;4952.603791696655;4953.529414705597;5128.358955130609;3516.2088530080528;3623.0398944279787;3630;3631.709463242987;3641.453781932731;628.4909223528956;638.3903372279555;650.817771024114;666.0675054923146;670.3932940688685;520.1651349583864;556.3157316500726;591.7455494137562;611.1382950040422;624.372505631837;9093.681721139728;9493.715188544355;9642.325037247465;9883.752906177258;10011.899881001242;615.5106690181317;631.8009826904511;669.2771806449024;713.0355224949299;715.5635062611802;4583.954160458419;4699;4749.145153872267;4751.168545504523;4755.785989630475;67189.66405167943;80363;111673;113067.43466282616;118932;60644.69677651583;66626;97868.51065744626;98435.50782246186;100154;53940.19089713658;69817.95273070908;85574;85836;85857.5707121473;8182.468139571147;8285.01564848209;8495.782076447123;8515.48907065578;8756.036835947913;52282.73858630683;54174.18738719001;54374.45625543694;55017.44982550123;56447.43552564586;70582.29417705757;77354.6132269335;78306.6084669573;79463;81503.62708288386;11684.713928191031;11862.169648124549;11985.28088314704;11990.520379184734;12316.692082698004;11406.756824192691;11523;11718.06255499541;12070.818937715765;12382.628521144019;8867.556622168995;12446.36902095444;12455.252684838939;12750.298733569743;12891.097623166288;14290.142591444546;14477.565673029825;14534.781978270546;15128.319225635092;15485.148316842682;13859.237741924291;13950.860491394957;13956.09285396446;14205.573832785032;14438.711225775216;10748;11358.26171298863;11689.357085360387;11791.764164716486;11861;10552.577896884346;10972.561097556327;11026.834597480884;11086.889131108586;11310.604128855779 08:21:33 INFO - PROCESS | 25125 | __end_tp_report 08:21:33 INFO - PROCESS | 25125 | __start_cc_report 08:21:33 INFO - PROCESS | 25125 | _x_x_mozilla_cycle_collect,915 08:21:33 INFO - PROCESS | 25125 | __end_cc_report 08:21:33 INFO - PROCESS | 25125 | __startTimestamp1467300093530__endTimestamp 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | ------- Summary: start ------- 08:21:33 INFO - PROCESS | 25125 | Number of tests: 6 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#0] dojo.html Cycles:165 Average:5305.72 Median:5519.06 stddev:595.89 (10.8%) stddev-sans-first:571.86 08:21:33 INFO - PROCESS | 25125 | Values: 3092.1 3119.3 3125.1 3152.5 3178.6 5178.2 5273.2 5344.6 5424.5 5454.0 5317.3 5343.4 5346.7 5399.1 5408.6 4784.8 4879.2 4881.3 4902.3 5034.4 4948.8 4978.3 4991.8 5004.3 5042.3 4775.3 4803.9 4830.2 4833.2 4907.8 4809.0 4816.5 4819.6 4893.6 4961.7 4837.9 4869.2 4869.8 4887.6 4901.0 5138.4 5277.8 5347.9 5349.3 5358.5 5771.3 5820.2 5828.8 5829.9 5831.8 5817.4 5845.5 5866.3 5866.8 5872.6 5237.1 5262.6 5297.3 5304.7 5454.1 5820.0 5870.8 5881.9 5882.6 5883.8 5594.0 5595.3 5636.0 5649.1 5651.2 5521.6 5638.3 5689.9 5698.0 5778.5 5720.8 5721.0 5726.2 5730.5 5763.1 5666.8 5699.2 5706.6 5715.4 5717.5 4280.5 4286.0 4330.8 4377.4 4389.7 3828.3 3836.7 3848.2 3894.4 3918.3 5369.7 5379.0 5393.8 5399.9 5412.4 5725.4 5730.3 5731.1 5734.1 5767.9 5286.9 5356.8 5365.5 5388.5 5423.5 4947.3 4949.3 4953.2 4953.9 4969.8 5653.0 5846.8 5863.1 5864.4 5866.7 5613.3 5665.8 5675.7 5679.9 5706.6 5799.8 5802.6 5807.5 5814.3 5816.1 5513.1 5523.4 5573.5 5585.2 5587.1 5673.7 5684.8 5723.5 5726.3 5783.2 5562.5 5572.9 5574.3 5577.5 5578.2 5421.9 5524.8 5545.4 5558.1 5560.2 5519.1 5522.0 5528.1 5529.2 5575.2 5627.6 5637.5 5642.9 5643.5 5696.7 5385.3 5396.3 5441.7 5475.8 5512.5 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#1] ext.html Cycles:180 Average:47530.95 Median:425012.00 stddev:79225.53 (18.6%) stddev-sans-first:79369.40 08:21:33 INFO - PROCESS | 25125 | Values: 594.8 623.5 627.5 627.6 645.1 30554.8 43389.6 43937.8 44030.0 44089.1 45598.8 45871.0 46019.3 46090.5 46154.8 8986.3 9119.5 9133.0 9140.1 9146.4 8969.8 9043.5 9059.6 9081.1 9089.1 9063.2 9098.9 9106.7 9111.3 9114.7 9044.5 9062.0 9072.6 9081.5 9099.2 8918.5 9023.8 9026.7 9028.1 9033.9 44084.8 44384.6 44469.3 44486.3 44489.0 3355.7 3370.7 3404.8 3477.6 3504.2 33147.3 33411.2 33476.2 34028.7 34721.3 4342.7 4382.9 4395.6 4405.4 4516.2 255520.0 255756.0 256099.2 256278.0 256337.0 57580.4 58865.0 59158.0 59268.4 59328.4 63226.0 64297.4 64566.0 70802.3 70930.0 17126.7 17279.8 17372.9 17408.1 17418.7 11282.4 11460.4 13245.4 13371.1 13372.2 16451.3 18312.7 18704.0 18720.2 19309.8 6624.9 6739.4 6867.1 6938.7 6952.5 919.3 1051.3 1100.9 1105.0 1180.7 30872.8 31390.8 31396.2 31788.0 31928.0 1101.9 1126.5 1154.6 1191.4 1212.1 16890.2 16902.0 16945.9 16950.2 17052.6 153181.0 153473.0 154752.0 154831.0 155020.0 58806.4 60009.4 60121.4 60148.4 60180.4 1252.1 1332.1 1373.9 1374.1 1380.4 31685.0 33781.3 34093.0 34425.0 34536.0 51462.7 51490.0 51989.0 52098.5 52297.0 422844.0 424960.0 425064.0 425431.0 425598.0 35792.3 44228.0 44853.3 45329.5 45547.8 45035.1 46166.5 49344.8 49524.5 50363.7 40519.2 41314.4 41840.2 41991.0 42430.6 40293.6 40429.0 40986.2 41431.6 41621.0 41111.4 41449.2 42437.8 42658.4 42672.8 35853.0 36396.3 36499.8 36837.4 37157.3 26365.0 26496.3 26583.9 26646.9 26779.9 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#2] jquery.html Cycles:180 Average:29737.96 Median:2045.41 stddev:82227.53 (4020.1%) stddev-sans-first:82428.70 08:21:33 INFO - PROCESS | 25125 | Values: 403.4 404.6 411.8 414.3 427.1 19296.1 19774.6 20227.3 20598.2 20630.5 18023.0 18109.2 18556.0 18727.3 18902.4 5090.1 5424.3 5458.2 5466.9 5469.3 3925.9 5323.1 5344.2 5701.8 5954.9 6054.8 6056.7 6074.6 6076.3 6081.8 5981.0 6420.9 6576.8 6641.2 6669.0 3845.2 5514.5 5805.2 5858.9 5864.7 14823.2 14961.6 14985.5 15064.1 15064.5 2329.0 2364.2 2419.8 2440.5 2979.6 10687.3 13505.3 14794.5 15311.9 15473.0 1957.0 2032.8 2040.4 2045.4 2117.0 85343.0 85365.6 86228.1 86931.1 86971.6 11058.7 11365.4 11526.6 11670.0 11753.5 16149.1 16324.6 16364.4 16389.3 16400.0 8326.7 8512.6 8557.4 8657.7 8663.2 8183.0 8184.5 8199.6 8319.8 8341.7 5027.9 5047.2 5059.9 5141.1 5187.8 1816.0 1940.1 2000.8 2045.5 2099.7 914.7 964.4 982.5 1025.5 1043.8 18669.2 19066.8 19282.9 19437.2 19451.1 949.6 1003.4 1006.7 1008.2 1058.6 10746.9 10996.4 10999.0 10999.1 11071.5 487618.0 495118.0 495813.0 498163.0 518331.0 86816.6 89542.0 89933.0 90152.5 90941.0 996.7 1002.1 1002.9 1007.4 1013.2 17611.2 17686.0 17782.6 17990.4 18284.3 41728.0 42207.8 42682.1 42946.8 43187.0 54899.7 55911.7 58350.0 65509.3 66522.0 8994.5 9004.4 9243.5 9386.0 11441.7 13849.5 14222.4 14748.0 14954.1 14954.6 12787.9 12911.6 12945.0 13116.2 13231.5 12395.0 12666.9 12765.0 12894.4 12963.6 13176.7 13230.6 13242.7 13353.6 13434.9 13171.3 13174.3 13198.9 13267.7 13275.8 12853.4 13070.8 13085.2 13092.3 13166.6 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#3] mootools.html Cycles:180 Average:5796.12 Median:4554.08 stddev:3278.77 (72.0%) stddev-sans-first:3270.66 08:21:33 INFO - PROCESS | 25125 | Values: 1314.7 1460.2 1482.0 1622.7 1765.5 8028.1 8395.5 8430.4 8599.4 8600.0 8517.7 8726.3 8731.3 8732.6 8739.7 2080.0 2266.6 2348.6 2371.3 2396.2 2361.9 2363.3 2369.0 2377.2 2379.8 2359.4 2376.3 2387.3 2388.0 2389.1 2042.2 2244.8 2330.9 2338.1 2351.3 2329.8 2333.3 2346.4 2347.6 2353.0 8815.1 8863.1 8876.2 8878.6 8889.7 5036.6 5071.7 5080.9 5113.7 5116.6 3458.7 3540.9 3601.3 3601.6 3644.9 1185.6 1212.9 1214.3 1236.0 1240.7 12129.9 12164.1 12170.0 12251.4 12264.6 4385.2 4483.3 4624.8 4664.4 4670.9 10230.4 10242.9 10246.4 10253.3 10254.8 5181.8 5203.8 5208.4 5211.0 5215.5 4296.7 4346.0 4413.5 4416.5 4469.5 4115.3 4118.7 4132.3 4137.2 4181.0 1219.6 1298.4 1329.8 1361.6 1371.1 832.7 961.4 965.2 971.6 976.0 5815.5 5895.2 5928.6 6114.0 6140.3 917.2 944.2 948.4 965.1 984.3 3991.9 4080.4 4087.9 4109.6 4119.4 10563.5 11027.4 11051.0 11053.7 11064.8 10808.2 10920.2 10928.3 10941.6 10964.2 8209.6 8360.8 8362.7 8365.4 8369.2 5737.3 5809.1 5894.8 6001.2 6064.3 9578.5 10183.9 10244.7 10249.8 10256.2 10054.1 10246.5 10357.1 10362.2 10375.0 7690.1 7778.6 7857.5 7871.0 7951.8 8293.5 8393.2 8442.1 8446.8 8460.2 7387.5 7651.9 7658.3 7717.8 7779.9 7472.4 7558.0 7599.7 7657.2 7673.2 7072.2 7108.7 7140.1 7140.2 7143.8 5136.9 5235.4 5320.6 5379.9 5403.3 5202.4 5211.0 5231.5 5275.2 5485.1 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#4] prototype.html Cycles:180 Average:4536.63 Median:5101.99 stddev:1291.77 (25.3%) stddev-sans-first:1256.14 08:21:33 INFO - PROCESS | 25125 | Values: 326.0 340.7 340.7 344.8 348.4 5128.3 5264.6 5275.3 5330.4 5366.5 5279.2 5296.8 5300.7 5310.9 5316.8 4090.7 4154.5 4167.0 4202.3 4214.8 3988.2 4004.1 4159.5 4179.5 4192.9 4167.5 4187.2 4190.9 4197.6 4198.5 4164.6 4178.7 4198.1 4211.9 4219.5 3641.6 3684.8 3726.5 3755.7 3767.1 5143.2 5165.7 5169.9 5174.5 5174.7 4799.6 4802.4 4813.6 4834.9 4838.2 5374.8 5502.8 5520.8 5531.1 5577.7 4043.7 4072.1 4093.3 4096.3 4098.8 5707.8 5729.3 5734.0 5738.9 5770.6 4089.8 4219.4 4221.2 4229.4 4236.4 4262.8 4283.5 4284.3 4285.0 4295.6 4811.6 4829.6 4852.7 4854.9 4870.5 5254.4 5565.6 5578.3 5583.6 5626.1 1353.6 1396.3 1415.9 1436.8 1440.5 975.5 988.6 999.0 1004.8 1008.2 5329.0 5331.7 5350.9 5352.7 5363.4 5653.9 5658.5 5658.6 5659.3 5669.4 5153.5 5281.3 5283.2 5352.1 5386.7 2649.4 2666.8 2668.3 2671.5 2676.3 5104.7 5115.9 5117.2 5122.7 5124.6 4785.8 5116.3 5118.9 5133.8 5137.5 5061.4 5065.4 5083.4 5091.0 5115.8 4936.0 4974.9 4982.5 5043.7 5043.7 4709.7 4917.0 4948.5 4967.3 4969.5 5099.3 5110.4 5116.3 5124.9 5130.9 3728.9 3743.9 3746.7 3759.4 3766.3 4710.8 4984.2 4997.9 5429.6 5579.2 5345.8 5410.9 5423.5 5436.6 5537.6 5512.8 5519.4 5521.0 5551.3 5580.6 5266.2 5462.7 5464.1 5473.9 5491.9 5509.7 5538.5 5540.3 5542.8 5575.7 5321.9 5396.4 5425.8 5452.5 5482.6 08:21:33 INFO - PROCESS | 25125 | 08:21:33 INFO - PROCESS | 25125 | [#5] yui.html Cycles:180 Average:19536.94 Median:4946.26 stddev:27395.46 (553.9%) stddev-sans-first:27436.29 08:21:33 INFO - PROCESS | 25125 | Values: 827.2 843.4 848.3 875.3 885.5 13334.7 14236.4 14280.4 14280.6 14311.3 13484.8 14342.1 14426.4 14455.1 14455.3 676.6 793.8 799.0 799.6 804.6 797.3 822.0 822.1 823.1 832.4 830.5 837.0 838.0 839.8 848.1 697.3 718.3 833.6 835.0 836.5 524.5 609.4 618.4 620.9 626.4 13002.5 13049.7 13106.1 13131.0 13138.5 14450.8 14839.7 14865.6 15069.1 15082.4 13140.2 13318.4 13327.1 13380.4 13559.1 4518.2 4618.1 4637.8 4671.4 4736.0 71113.9 71235.3 71884.0 71956.0 72072.6 11632.8 11647.2 11686.4 11692.4 11987.6 20745.9 20898.9 20912.8 20925.9 20946.1 8732.7 8735.8 8746.5 8756.0 8921.5 4825.7 4939.9 4952.6 4953.5 5128.4 3516.2 3623.0 3630.0 3631.7 3641.5 628.5 638.4 650.8 666.1 670.4 520.2 556.3 591.7 611.1 624.4 9093.7 9493.7 9642.3 9883.8 10011.9 615.5 631.8 669.3 713.0 715.6 4584.0 4699.0 4749.1 4751.2 4755.8 67189.7 80363.0 111673.0 113067.4 118932.0 60644.7 66626.0 97868.5 98435.5 100154.0 53940.2 69818.0 85574.0 85836.0 85857.6 8182.5 8285.0 8495.8 8515.5 8756.0 52282.7 54174.2 54374.5 55017.4 56447.4 70582.3 77354.6 78306.6 79463.0 81503.6 11684.7 11862.2 11985.3 11990.5 12316.7 11406.8 11523.0 11718.1 12070.8 12382.6 8867.6 12446.4 12455.3 12750.3 12891.1 14290.1 14477.6 14534.8 15128.3 15485.1 13859.2 13950.9 13956.1 14205.6 14438.7 10748.0 11358.3 11689.4 11791.8 11861.0 10552.6 10972.6 11026.8 11086.9 11310.6 08:21:33 INFO - PROCESS | 25125 | -------- Summary: end -------- 08:21:33 INFO - PROCESS | 25125 | 08:21:34 INFO - TEST-INFO | 25125: exit 0 08:21:34 INFO - TEST-OK | dromaeo_css | took 1113894ms 08:21:34 INFO - TEST-START | kraken 08:21:34 INFO - operating with platform_type : linux_ 08:21:34 INFO - Initialising browser for kraken test... 08:21:34 INFO - TEST-INFO | started process 25320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPo1Tj/profile http://localhost:34817/getInfo.html) 08:21:38 INFO - PROCESS | 25320 | __metrics Screen width/height:1600/1200 08:21:38 INFO - PROCESS | 25320 | colorDepth:24 08:21:38 INFO - PROCESS | 25320 | Browser inner width/height: 1024/697 08:21:38 INFO - PROCESS | 25320 | __metrics 08:21:39 INFO - PROCESS | 25320 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:40 INFO - TEST-INFO | 25320: exit 0 08:21:40 INFO - Browser initialized. 08:21:40 INFO - Running cycle 1/1 for kraken test... 08:21:40 INFO - TEST-INFO | started process 25401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPo1Tj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:51 INFO - PROCESS | 25401 | RSS: Main: 156876800 08:21:51 INFO - PROCESS | 25401 | 08:21:54 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:55 INFO - PROCESS | 25401 | RSS: Main: 215089152 08:21:55 INFO - PROCESS | 25401 | 08:21:57 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-dft) 08:21:58 INFO - PROCESS | 25401 | RSS: Main: 203829248 08:21:58 INFO - PROCESS | 25401 | 08:22:01 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-fft) 08:22:02 INFO - PROCESS | 25401 | RSS: Main: 269611008 08:22:02 INFO - PROCESS | 25401 | 08:22:04 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-oscillator) 08:22:04 INFO - PROCESS | 25401 | RSS: Main: 179769344 08:22:04 INFO - PROCESS | 25401 | 08:22:07 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:07 INFO - PROCESS | 25401 | RSS: Main: 184217600 08:22:07 INFO - PROCESS | 25401 | 08:22:10 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:11 INFO - PROCESS | 25401 | RSS: Main: 219189248 08:22:11 INFO - PROCESS | 25401 | 08:22:14 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:15 INFO - PROCESS | 25401 | RSS: Main: 221392896 08:22:15 INFO - PROCESS | 25401 | 08:22:18 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34817/tests/kraken/driver.html?testName=json-parse-financial) 08:22:18 INFO - PROCESS | 25401 | RSS: Main: 221581312 08:22:18 INFO - PROCESS | 25401 | 08:22:20 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:20 INFO - PROCESS | 25401 | RSS: Main: 207781888 08:22:20 INFO - PROCESS | 25401 | 08:22:22 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:23 INFO - PROCESS | 25401 | RSS: Main: 212107264 08:22:23 INFO - PROCESS | 25401 | 08:22:25 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:25 INFO - PROCESS | 25401 | RSS: Main: 212938752 08:22:25 INFO - PROCESS | 25401 | 08:22:28 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:28 INFO - PROCESS | 25401 | RSS: Main: 231915520 08:22:28 INFO - PROCESS | 25401 | 08:22:31 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:32 INFO - PROCESS | 25401 | RSS: Main: 225218560 08:22:32 INFO - PROCESS | 25401 | 08:22:33 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34817/tests/kraken/driver.html?testName=ai-astar) 08:22:34 INFO - PROCESS | 25401 | RSS: Main: 267603968 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | __start_tp_report 08:22:34 INFO - PROCESS | 25401 | _x_x_mozilla_page_load 08:22:34 INFO - PROCESS | 25401 | _x_x_mozilla_page_load_details 08:22:34 INFO - PROCESS | 25401 | |i|pagename|runs| 08:22:34 INFO - PROCESS | 25401 | |0;ai-astar;104;112;111;113;111;112;110;113;111;111 08:22:34 INFO - PROCESS | 25401 | |1;audio-beat-detection;144;118;126;173;117;119;149;121;162;119 08:22:34 INFO - PROCESS | 25401 | |2;audio-dft;162;163;161;161;161;161;160;163;161;162 08:22:34 INFO - PROCESS | 25401 | |3;audio-fft;74;74;75;123;75;75;74;74;103;75 08:22:34 INFO - PROCESS | 25401 | |4;audio-oscillator;83;84;117;84;84;84;118;84;83;125 08:22:34 INFO - PROCESS | 25401 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;118;117;116 08:22:34 INFO - PROCESS | 25401 | |6;imaging-darkroom;146;146;146;147;147;146;146;147;146;145 08:22:34 INFO - PROCESS | 25401 | |7;imaging-desaturate;95;94;95;96;94;95;96;95;96;96 08:22:34 INFO - PROCESS | 25401 | |8;json-parse-financial;52;53;53;51;52;52;52;52;53;52 08:22:34 INFO - PROCESS | 25401 | |9;json-stringify-tinderbox;59;60;60;60;60;59;59;59;60;59 08:22:34 INFO - PROCESS | 25401 | |10;stanford-crypto-aes;75;75;74;83;74;75;74;83;75;81 08:22:34 INFO - PROCESS | 25401 | |11;stanford-crypto-ccm;149;117;117;134;117;119;117;126;155;133 08:22:34 INFO - PROCESS | 25401 | |12;stanford-crypto-pbkdf2;158;159;158;157;156;164;156;157;152;152 08:22:34 INFO - PROCESS | 25401 | |13;stanford-crypto-sha256-iterative;64;64;64;62;63;65;61;61;60;60 08:22:34 INFO - PROCESS | 25401 | __end_tp_report 08:22:34 INFO - PROCESS | 25401 | __start_cc_report 08:22:34 INFO - PROCESS | 25401 | _x_x_mozilla_cycle_collect,1641 08:22:34 INFO - PROCESS | 25401 | __end_cc_report 08:22:34 INFO - PROCESS | 25401 | __startTimestamp1467300154121__endTimestamp 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | ------- Summary: start ------- 08:22:34 INFO - PROCESS | 25401 | Number of tests: 14 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.57 (2.3%) stddev-sans-first:1.01 08:22:34 INFO - PROCESS | 25401 | Values: 104.0 112.0 111.0 113.0 111.0 112.0 110.0 113.0 111.0 111.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:135.00 stddev:20.69 (15.3%) stddev-sans-first:21.67 08:22:34 INFO - PROCESS | 25401 | Values: 144.0 118.0 126.0 173.0 117.0 119.0 149.0 121.0 162.0 119.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:22:34 INFO - PROCESS | 25401 | Values: 162.0 163.0 161.0 161.0 161.0 161.0 160.0 163.0 161.0 162.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:16.91 (22.7%) stddev-sans-first:17.67 08:22:34 INFO - PROCESS | 25401 | Values: 74.0 74.0 75.0 123.0 75.0 75.0 74.0 74.0 103.0 75.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:17.65 (21.0%) stddev-sans-first:18.22 08:22:34 INFO - PROCESS | 25401 | Values: 83.0 84.0 117.0 84.0 84.0 84.0 118.0 84.0 83.0 125.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:22:34 INFO - PROCESS | 25401 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:22:34 INFO - PROCESS | 25401 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 145.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 08:22:34 INFO - PROCESS | 25401 | Values: 95.0 94.0 95.0 96.0 94.0 95.0 96.0 95.0 96.0 96.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 08:22:34 INFO - PROCESS | 25401 | Values: 52.0 53.0 53.0 51.0 52.0 52.0 52.0 52.0 53.0 52.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:22:34 INFO - PROCESS | 25401 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 59.0 59.0 60.0 59.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:75.00 stddev:3.81 (5.1%) stddev-sans-first:3.98 08:22:34 INFO - PROCESS | 25401 | Values: 75.0 75.0 74.0 83.0 74.0 75.0 74.0 83.0 75.0 81.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.50 stddev:14.14 (10.9%) stddev-sans-first:12.88 08:22:34 INFO - PROCESS | 25401 | Values: 149.0 117.0 117.0 134.0 117.0 119.0 117.0 126.0 155.0 133.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.50 stddev:3.45 (2.2%) stddev-sans-first:3.63 08:22:34 INFO - PROCESS | 25401 | Values: 158.0 159.0 158.0 157.0 156.0 164.0 156.0 157.0 152.0 152.0 08:22:34 INFO - PROCESS | 25401 | 08:22:34 INFO - PROCESS | 25401 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.50 stddev:1.84 (2.9%) stddev-sans-first:1.86 08:22:34 INFO - PROCESS | 25401 | Values: 64.0 64.0 64.0 62.0 63.0 65.0 61.0 61.0 60.0 60.0 08:22:34 INFO - PROCESS | 25401 | -------- Summary: end -------- 08:22:34 INFO - PROCESS | 25401 | 08:22:35 INFO - TEST-INFO | 25401: exit 0 08:22:35 INFO - TEST-OK | kraken | took 60825ms 08:22:35 INFO - SUITE-END | took 1174s 08:22:35 INFO - Completed test suite (00:19:34) 08:22:35 INFO - javascript benchmark 08:22:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.0569226385956, 3119.313750974785, 3125.078101959921, 3152.5113607390836, 3178.5550022996786, 5178.249153872695, 5273.235380869781, 5344.599155063372, 5424.484673955978, 5454.045542030139, 5317.255584218213, 5343.385510666275, 5346.732663366835, 5399.1091469907515, 5408.621396502246, 4784.832530861429, 4879.170541008037, 4881.316615673791, 4902.264660300948, 5034.42104158021, 4948.752562371867, 4978.327925730016, 4991.7504124793795, 5004.349434573501, 5042.268871013701, 4775.283707443877, 4803.9039219215765, 4830.178869592142, 4833.226683730604, 4907.779149938261, 4808.951910480885, 4816.51834816519, 4819.590334821544, 4893.559579637814, 4961.652684312099, 4837.879053023703, 4869.245266983623, 4869.805207791719, 4887.608991280689, 4901.0, 5138.409082955471, 5277.788888444457, 5347.919781203285, 5349.251104845324, 5358.517733404013, 5771.336296325934, 5820.214271073393, 5828.825135245949, 5829.854253643693, 5831.795887143972, 5817.447342502455, 5845.503132233765, 5866.325372582165, 5866.794662186803, 5872.618279811799, 5237.083510385705, 5262.55268302191, 5297.311349524537, 5304.73476326186, 5454.10007348787, 5819.970900145472, 5870.765169393262, 5881.911771323434, 5882.55880808941, 5883.764649413975, 5594.0, 5595.328560572757, 5636.0, 5649.096144616841, 5651.208830763697, 5521.585881058937, 5638.295213098363, 5689.886202275931, 5697.971510142423, 5778.479936805707, 5720.799772007959, 5720.971395142998, 5726.226959360433, 5730.455606717355, 5763.077907534775, 5666.801661941812, 5699.202111704365, 5706.572007099484, 5715.371309155989, 5717.456841600041, 4280.486341638961, 4285.97857010713, 4330.805113769888, 4377.365282034088, 4389.6927215095275, 3828.349180639242, 3836.731428800013, 3848.230353929225, 3894.3963685628773, 3918.3338832398563, 5369.731513424314, 5378.97310513445, 5393.83818485446, 5399.946000539944, 5412.431694672082, 5725.370209277059, 5730.312362516442, 5731.111677689964, 5734.139879018181, 5767.8558036049435, 5286.920696189561, 5356.758945847446, 5365.517103460707, 5388.46115388458, 5423.538999185034, 4947.307376967227, 4949.307097006422, 4953.18272485036, 4953.876153096201, 4969.776360063805, 5653.010723123437, 5846.824595262149, 5863.120531920246, 5864.413558644102, 5866.70666466675, 5613.270274864241, 5665.801696940587, 5675.7445914933105, 5679.858003549944, 5706.572007099568, 5799.82600521985, 5802.564807639359, 5807.477327040587, 5814.30228372598, 5816.127580862904, 5513.145462453326, 5523.447655234444, 5573.470520300727, 5585.162225666182, 5587.106063029895, 5673.716314184357, 5684.8294551163535, 5723.456271654186, 5726.341470730919, 5783.161441590862, 5562.499375056264, 5572.86067848307, 5574.275344205227, 5577.470140336662, 5578.163275508706, 5421.945780542144, 5524.779008839601, 5545.417731138334, 5558.055130627722, 5560.165975103767, 5519.061759500814, 5522.0, 5528.06022976087, 5529.198266251291, 5575.2473416088305, 5627.606067575231, 5637.49262566371, 5642.943570564242, 5643.548516118783, 5696.686682232517, 5385.2999110117, 5396.325459317585, 5441.673499590037, 5475.780968761205, 5512.476314750093], "value": 5265.976321404748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8275000249928, 623.5043140703141, 627.5262177056319, 627.6391075131801, 645.0839807473387, 30554.847225763868, 43389.56610433895, 43937.7803110984, 44030.0, 44089.11821763563, 45598.77200613992, 45871.0, 46019.30971035437, 46090.53909460904, 46154.769226153905, 8986.2810975122, 9119.49842758648, 9133.0, 9140.085991400872, 9146.405483643575, 8969.820603587925, 9043.547822608876, 9059.637614495412, 9081.137291957253, 9089.136532029446, 9063.184313411792, 9098.86351704725, 9106.726798196065, 9111.316651251183, 9114.680986165486, 9044.502552359618, 9062.0, 9072.591733372014, 9081.45511269326, 9099.226565741952, 8918.509481978488, 9023.81952360949, 9026.729198124067, 9028.097190280985, 9033.864492032559, 44084.779576102235, 44384.55615443837, 44469.332960005624, 44486.33270500945, 44489.0, 3355.6644335566493, 3370.679785420381, 3404.8127352995575, 3477.565304336958, 3504.1590018395655, 33147.33705325904, 33411.16472088193, 33476.1630959228, 34028.6597134028, 34721.30557388838, 4342.6742994275555, 4382.868513944587, 4395.648348132142, 4405.405270288502, 4516.20966330894, 255520.0, 255756.0, 256099.1950402491, 256278.0, 256337.0, 57580.42419575834, 58865.0, 59158.0, 59268.40731592629, 59328.40671593315, 63226.0, 64297.357026429134, 64566.0, 70802.2919770806, 70930.0, 17126.743098853527, 17279.827201728072, 17372.913135434243, 17408.129593520272, 17418.65162696739, 11282.435878206057, 11460.369679667698, 13245.403956821967, 13371.130876492996, 13372.197668139943, 16451.25969331383, 18312.725309120375, 18703.971281579645, 18720.157592908352, 19309.806901930802, 6624.940009598441, 6739.449926516831, 6867.141607299088, 6938.722451101899, 6952.5480843745, 919.287552147078, 1051.3324039234988, 1100.8954149355798, 1105.0275757333495, 1180.740237147826, 30872.84563577168, 31390.843045784626, 31396.215094622818, 31788.0, 31928.0, 1101.911847052234, 1126.4987080749152, 1154.6362895687998, 1191.362620997762, 1212.1333246728454, 16890.239939202766, 16902.0, 16945.915270423815, 16950.23723932426, 17052.573685657957, 153181.0, 153473.0, 154752.0, 154831.0, 155020.0, 58806.41193588095, 60009.399906000384, 60121.398786012454, 60148.39851601428, 60180.39819601835, 1252.1047451072527, 1332.1274565159836, 1373.9106958047696, 1374.1411617739113, 1380.3995262061035, 31685.0, 33781.324373512885, 34093.0, 34424.99313238229, 34536.0, 51462.74268628633, 51490.0, 51989.0, 52098.47901520936, 52297.0, 422844.0, 424960.0, 425064.0, 425431.0, 425598.0, 35792.28415431625, 44228.0, 44853.32720009268, 45329.546704532535, 45547.77226113848, 45035.09929801451, 46166.53833461623, 49344.75327623339, 49524.50475495199, 50363.74818125886, 40519.189616206924, 41314.380284295155, 41840.1631967365, 41991.0, 42430.57569424266, 40293.59706402898, 40429.0, 40986.1802763949, 41431.58568414398, 41621.0, 41111.38332925068, 41449.171016580105, 42437.78781106075, 42658.360124598774, 42672.78663606662, 35853.0, 36396.27207455889, 36499.817500913385, 36837.44743828898, 37157.25685486221, 26365.0, 26496.337591560365, 26583.867080664473, 26646.928934261377, 26779.866100669373], "value": 19693.60458210687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.39087977154486, 404.5691338724258, 411.82085792680175, 414.3122416788131, 427.06259759827174, 19296.131674074666, 19774.604507909833, 20227.292044778435, 20598.1760729571, 20630.48423789406, 18023.0, 18109.1850866711, 18556.0, 18727.25090996362, 18902.43292701221, 5090.10923088459, 5424.349078110632, 5458.181272809071, 5466.863328416782, 5469.316335458067, 3925.862594809182, 5323.148296272597, 5344.22508736233, 5701.8026214495, 5954.9404505955035, 6054.788082417116, 6056.666883321415, 6074.63552186868, 6076.301225359096, 6081.78713745019, 5981.005860106816, 6420.871582568369, 6576.835579110512, 6641.169853768279, 6669.032990216416, 3845.2309538092495, 5514.531264842493, 5805.245318108661, 5858.941410585882, 5864.70676466175, 14823.18472484013, 14961.551153465414, 14985.475508357154, 15064.096154230781, 15064.472743454036, 2328.988355058231, 2364.1725396111397, 2419.818513611486, 2440.5240978009297, 2979.6275465566805, 10687.251892367538, 13505.324733763273, 14794.482193123189, 15311.928165028341, 15473.0, 1957.0, 2032.8068833460798, 2040.4221494757776, 2045.3659365596714, 2116.9576608467746, 85343.0, 85365.57317213374, 86228.13771862263, 86931.13068869356, 86971.56514217451, 11058.723531911766, 11365.431728413547, 11526.59656912004, 11669.99999999983, 11753.471093800628, 16149.111798850941, 16324.591885202964, 16364.427245046367, 16389.344426223055, 16400.0, 8326.6669333226, 8512.552866012793, 8557.400981931329, 8657.653693852302, 8663.176998185163, 8182.959085204536, 8184.468009579358, 8199.590020498952, 8319.8336033279, 8341.749747507585, 5027.874303142377, 5047.192449208183, 5059.924101138412, 5141.100307446182, 5187.792488300502, 1815.9770488894117, 1940.1172466527696, 2000.8099230573073, 2045.457953642286, 2099.6745504446835, 914.7255823252998, 964.392432767352, 982.5234761140841, 1025.5333823110466, 1043.780806030742, 18669.159887805083, 19066.809331906505, 19282.90358548198, 19437.22251109968, 19451.12469938856, 949.5726922884592, 1003.4079892863246, 1006.6728313298207, 1008.2337423558149, 1058.5765693722572, 10746.892531074589, 10996.395198264172, 10999.0, 10999.065079468175, 11071.501782419811, 487618.0, 495118.0, 495813.0, 498163.0, 518331.0, 86816.56591717128, 89542.0, 89933.0, 90152.54923725339, 90941.0, 996.6611352140162, 1002.1281485108003, 1002.8896821349646, 1007.4308015970953, 1013.2248829645474, 17611.20749566247, 17686.0, 17782.644347112728, 17990.37033703814, 18284.268629255213, 41728.0, 42207.788961055, 42682.1463570733, 42946.78526607347, 43187.0, 54899.72550137224, 55911.720441397534, 58350.0, 65509.34490655032, 66522.0, 8994.50530220818, 9004.41471304363, 9243.537823108683, 9386.014468480984, 11441.656750297505, 13849.515266966011, 14222.431102755774, 14748.0, 14954.102753834804, 14954.626134346729, 12787.87212127904, 12911.612651620466, 12945.0, 13116.213027218397, 13231.470741170246, 12395.008399328213, 12666.936665316614, 12765.0, 12894.355282236038, 12963.611091667264, 13176.73646527045, 13230.603081907559, 13242.735145297233, 13353.596352656616, 13434.865651343362, 13171.2755798432, 13174.341282936006, 13198.868011319764, 13267.66830829237, 13275.800862987257, 12853.421596028014, 13070.80393794075, 13085.214887106804, 13092.345382731015, 13166.605001849959], "value": 9627.745289848179, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.7370525894823, 1460.2479722942687, 1481.9851801481984, 1622.69168857917, 1765.5056584156432, 8028.116907140217, 8395.496270223783, 8430.409871309012, 8599.35504837138, 8599.95700021499, 8517.701880434186, 8726.345524085687, 8731.25784308333, 8732.607032683529, 8739.694110706127, 2079.979200208001, 2266.5920134375806, 2348.6242201247805, 2371.3241726108063, 2396.2451827674226, 2361.9409514762096, 2363.267387109993, 2368.9644655330185, 2377.2274010946426, 2379.8334116611845, 2359.3629719975597, 2376.310869847742, 2387.2957477544164, 2388.0447820871705, 2389.080204121417, 2042.1525067097136, 2244.7867452591977, 2330.93007209784, 2338.0647740903605, 2351.259353303704, 2329.7670232976734, 2333.300009996994, 2346.4133966508375, 2347.5657003454417, 2353.035255545218, 8815.118488151198, 8863.069377715376, 8876.245519130882, 8878.644854205824, 8889.73330800077, 5036.622253330978, 5071.7210553419545, 5080.898382032376, 5113.718745468997, 5116.616253780944, 3458.6714262145056, 3540.8760693375607, 3601.3157500075163, 3601.58581763098, 3644.908877278063, 1185.6324539392815, 1212.9029677625856, 1214.283572692116, 1236.048242852998, 1240.7332423528985, 12129.939350303192, 12164.08769342303, 12170.026397888148, 12251.448684809206, 12264.632061038183, 4385.210662080793, 4483.349914262414, 4624.815007399734, 4664.416947881515, 4670.859874203779, 10230.437325947145, 10242.897571024343, 10246.436445995541, 10253.282270241012, 10254.794904101876, 5181.844544663666, 5203.843884683465, 5208.427073021964, 5211.009908117521, 5215.504527069922, 4296.742195468282, 4345.97827010863, 4413.492448368414, 4416.53626369233, 4469.508354081048, 4115.300398932189, 4118.691098167649, 4132.297509423405, 4137.172565486914, 4180.958190418118, 1219.634109767084, 1298.3767791460152, 1329.8098202109252, 1361.5915225432332, 1371.1156304183746, 832.7168762620738, 961.3558915526474, 965.1554889471712, 971.582219645545, 975.9609615615295, 5815.534757219497, 5895.204147440127, 5928.555358348141, 6113.96943015291, 6140.324564297924, 917.1928702741545, 944.2398868910593, 948.3551185194134, 965.1169180200038, 984.3306551544875, 3991.8802435926386, 4080.449139366207, 4087.8773636790943, 4109.568495308009, 4119.423280740699, 10563.524641391155, 11027.44862756859, 11051.0, 11053.668389948314, 11064.778704425866, 10808.189385796097, 10920.18098642605, 10928.289661172157, 10941.617043403443, 10964.17768667353, 8209.58952052395, 8360.790980225422, 8362.749117526484, 8365.414420990593, 8369.163083691705, 5737.340205876378, 5809.070548712186, 5894.764209431746, 6001.159837622824, 6064.332923378337, 9578.473183974947, 10183.898161018295, 10244.692659220234, 10249.795004099728, 10256.230782691178, 10054.095131438205, 10246.487675616338, 10357.119644829972, 10362.171026317727, 10375.014373634493, 7690.115636701851, 7778.649960751666, 7857.528548287121, 7871.0, 7951.761447156595, 8293.460925039853, 8393.202645748644, 8442.113578074213, 8446.831063378575, 8460.153984601737, 7387.519811212254, 7651.885221721567, 7658.310752032344, 7717.768466946, 7779.92220077792, 7472.439567032603, 7558.0, 7599.734009309869, 7657.234276572521, 7673.194314596887, 7072.186698529529, 7108.715651373887, 7140.07179066718, 7140.214576396488, 7143.785686429415, 5136.871578210575, 5235.3717553893775, 5320.627556071038, 5379.946200537945, 5403.270558474555, 5202.375714914083, 5211.00078065564, 5231.476852314738, 5275.182346736262, 5485.0949593318255], "value": 4651.682023877191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.9745076223381, 340.6814628322518, 340.7035878785457, 344.81207741780725, 348.3694512931594, 5128.282040514322, 5264.631475796696, 5275.31420915281, 5330.413654498002, 5366.517013468787, 5279.155335146377, 5296.788128474866, 5300.708461034642, 5310.867228319294, 5316.813911513098, 4090.6727461803134, 4154.543000269968, 4167.0, 4202.264603694357, 4214.831406743727, 3988.1824226033737, 4004.0790618157694, 4159.521655009682, 4179.498460184767, 4192.916141677165, 4167.458230430055, 4187.246295666779, 4190.895227619319, 4197.580241975793, 4198.475190601175, 4164.625183733463, 4178.707490475653, 4198.13938142683, 4211.873643790691, 4219.493660760729, 3641.563012438498, 3684.8395879724276, 3726.5341832270965, 3755.7370984031127, 3767.1147280389087, 5143.202803565453, 5165.708572856785, 5169.922451163236, 5174.4825517448335, 5174.663646862942, 4799.592034677056, 4802.351682522884, 4813.590844778198, 4834.927476087862, 4838.177509823338, 5374.758135883894, 5502.752376143083, 5520.806771763009, 5531.115021596565, 5577.69322687252, 4043.7262262387253, 4072.1448495815916, 4093.263212621727, 4096.303628383182, 4098.815553300109, 5707.77168913243, 5729.255196824386, 5733.971330143323, 5738.885222295572, 5770.596058275923, 4089.8364065437645, 4219.409282700424, 4221.197972385237, 4229.407882896336, 4236.406903033578, 4262.808173632194, 4283.507396649363, 4284.250256205151, 4285.0, 4295.634871035934, 4811.5805837278085, 4829.589484893823, 4852.660313778072, 4854.927176092361, 4870.512948705101, 5254.395744489356, 5565.638233514808, 5578.30271216098, 5583.581231407661, 5626.127950167731, 1353.5871559174545, 1396.2599822094305, 1415.8796502297214, 1436.7988481612583, 1440.4958264607303, 975.4829940131741, 988.5502096546054, 998.9500524973722, 1004.7940172264668, 1008.2337423558002, 5328.973355133277, 5331.680099194061, 5350.946490535045, 5352.732363381893, 5363.383210930715, 5653.858653533613, 5658.490735833795, 5658.632188907708, 5659.349174844863, 5669.376368599451, 5153.458886816905, 5281.339832520935, 5283.1546952487415, 5352.116900711339, 5386.67679939197, 2649.4436168404463, 2666.7733242674203, 2668.2795645175693, 2671.5324818156746, 2676.3175390275355, 5104.702883702349, 5115.897682046339, 5117.155669314596, 5122.743862806919, 5124.641275110706, 4785.832495862698, 5116.309298244763, 5118.87566659832, 5133.79464821403, 5137.537621614073, 5061.367329083864, 5065.35376002808, 5083.415407228216, 5090.974545127251, 5115.7953681852305, 4935.975320123376, 4974.925376119433, 4982.526659967298, 5043.672161309503, 5043.722595257296, 4709.670323077352, 4916.950830491793, 4948.529889660476, 4967.279744436964, 4969.503049695146, 5099.286099945936, 5110.437851836221, 5116.283720279238, 5124.948750512447, 5130.895808036084, 3728.8881333560034, 3743.8502459901297, 3746.662800347982, 3759.3984962405884, 3766.2844059628583, 4710.7859306126065, 4984.22744474607, 4997.85006449807, 5429.5656347492895, 5579.246801681721, 5345.839624811262, 5410.891782164414, 5423.511883930465, 5436.565074794086, 5537.5569954402745, 5512.80705175317, 5519.399374181442, 5520.957245819072, 5551.25058117149, 5580.581456390706, 5266.2363957225225, 5462.726863656881, 5464.131331051071, 5473.863153421196, 5491.862703432446, 5509.696966666872, 5538.529225015919, 5540.307461567304, 5542.8337149885565, 5575.745457272082, 5321.893562128658, 5396.379416367168, 5425.810096646598, 5452.454754524516, 5482.588805839658], "value": 4132.689119479321, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.2058823529416, 843.4348986179259, 848.3415617829079, 875.3216257400513, 885.481993034075, 13334.66663333416, 14236.359363828627, 14280.357383917722, 14280.642983925407, 14311.284435778209, 13484.797728034062, 14342.13947163171, 14426.35081421336, 14455.060421072649, 14455.277236138203, 676.5703778100892, 793.8015496125969, 799.0331698644646, 799.6441583495347, 804.5775967616989, 797.2824457987799, 822.0053734980651, 822.0628483528782, 823.1357075071181, 832.3923535818856, 830.5307501261768, 837.0, 838.0488145954355, 839.7564706235185, 848.1264297773304, 697.3201128899333, 718.3463048625725, 833.6207025803245, 834.9813227861998, 836.4939211776879, 524.5331654827207, 609.402785270433, 618.3630860213987, 620.9410106039919, 626.3861415812484, 13002.544910928073, 13049.673758156026, 13106.148100373444, 13131.0, 13138.540151094665, 14450.783238251435, 14839.703205935928, 14865.628359290997, 15069.09585424878, 15082.396704131932, 13140.157042596033, 13318.40626936689, 13327.133736307205, 13380.397882095329, 13559.118657287245, 4518.231900576877, 4618.099470603233, 4637.791299391535, 4671.439427268716, 4735.976320118378, 71113.93329100119, 71235.28764712339, 71884.0, 71956.0, 72072.639636802, 11632.825507617392, 11647.184697071123, 11686.357250351142, 11692.35692036946, 11987.640370788717, 20745.89627051855, 20898.895505522374, 20912.790872091387, 20925.89537052305, 20946.057427415803, 8732.65069397217, 8735.781605459915, 8746.518941458153, 8755.956220218986, 8921.509316987627, 4825.689348730523, 4939.925901111486, 4952.603791696655, 4953.529414705597, 5128.358955130609, 3516.2088530080528, 3623.0398944279787, 3630.0, 3631.709463242987, 3641.453781932731, 628.4909223528956, 638.3903372279555, 650.817771024114, 666.0675054923146, 670.3932940688685, 520.1651349583864, 556.3157316500726, 591.7455494137562, 611.1382950040422, 624.372505631837, 9093.681721139728, 9493.715188544355, 9642.325037247465, 9883.752906177258, 10011.899881001242, 615.5106690181317, 631.8009826904511, 669.2771806449024, 713.0355224949299, 715.5635062611802, 4583.954160458419, 4699.0, 4749.145153872267, 4751.168545504523, 4755.785989630475, 67189.66405167943, 80363.0, 111673.0, 113067.43466282616, 118932.0, 60644.69677651583, 66626.0, 97868.51065744626, 98435.50782246186, 100154.0, 53940.19089713658, 69817.95273070908, 85574.0, 85836.0, 85857.5707121473, 8182.468139571147, 8285.01564848209, 8495.782076447123, 8515.48907065578, 8756.036835947913, 52282.73858630683, 54174.18738719001, 54374.45625543694, 55017.44982550123, 56447.43552564586, 70582.29417705757, 77354.6132269335, 78306.6084669573, 79463.0, 81503.62708288386, 11684.713928191031, 11862.169648124549, 11985.28088314704, 11990.520379184734, 12316.692082698004, 11406.756824192691, 11523.0, 11718.06255499541, 12070.818937715765, 12382.628521144019, 8867.556622168995, 12446.36902095444, 12455.252684838939, 12750.298733569743, 12891.097623166288, 14290.142591444546, 14477.565673029825, 14534.781978270546, 15128.319225635092, 15485.148316842682, 13859.237741924291, 13950.860491394957, 13956.09285396446, 14205.573832785032, 14438.711225775216, 10748.0, 11358.26171298863, 11689.357085360387, 11791.764164716486, 11861.0, 10552.577896884346, 10972.561097556327, 11026.834597480884, 11086.889131108586, 11310.604128855779], "value": 7364.522304841626, "unit": "score"}], "name": "dromaeo_css", "value": 7217.614406569736, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 113.0, 111.0, 112.0, 110.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 126.0, 173.0, 117.0, 119.0, 149.0, 121.0, 162.0, 119.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 161.0, 161.0, 160.0, 163.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 123.0, 75.0, 75.0, 74.0, 74.0, 103.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 117.0, 84.0, 84.0, 84.0, 118.0, 84.0, 83.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 83.0, 74.0, 75.0, 74.0, 83.0, 75.0, 81.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 117.0, 134.0, 117.0, 119.0, 117.0, 126.0, 155.0, 133.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 158.0, 157.0, 156.0, 164.0, 156.0, 157.0, 152.0, 152.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 62.0, 63.0, 65.0, 61.0, 61.0, 60.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1478.4000000000003, "alertThreshold": 2.0}]} 08:22:35 INFO - Return code: 0 08:22:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:35 INFO - # TBPL SUCCESS # 08:22:35 INFO - Running post-action listener: _resource_record_post_action 08:22:35 INFO - ##### 08:22:35 INFO - ##### Finished run-tests step (success) 08:22:35 INFO - ##### 08:22:35 INFO - Running post-run listener: _resource_record_post_run 08:22:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 552411136; Read time: 216; Write time: 383464 08:22:35 INFO - TinderboxPrint: CPU usage
13.1% 08:22:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 216 08:22:35 INFO - TinderboxPrint: I/O write bytes / time
552,411,136 / 383,464 08:22:35 INFO - TinderboxPrint: CPU idle
8,270.3 (86.9%) 08:22:35 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 08:22:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256270336; Read time: 0; Write time: 210888 08:22:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296140800; Read time: 200; Write time: 172576 08:22:36 INFO - Running post-run listener: _upload_blobber_files 08:22:36 INFO - Blob upload gear active. 08:22:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:36 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 08:22:36 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:36 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:40 INFO - (blobuploader) - INFO - Done attempting. 08:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:22:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:40 INFO - (blobuploader) - INFO - Done attempting. 08:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:41 INFO - (blobuploader) - INFO - Done attempting. 08:22:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:41 INFO - Return code: 0 08:22:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3b143c6ab5b601fe96e8d3449640e9e86233825aef866967b794a2661514bce45b21ce6e2657475d1101cbe73ba1b57d9920c6f7eef6b96857a10158bcbdafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/101dd47b65bebcf115b98c3e14e5668957a92c65b559664202b6a357653c2937e7b2a9eb66fcebe16eb74df99c1e32cd4a65a2a798df38730d9dbd1977a0687e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add8838ffaab65236d44e2ae5f2b1402fc55f9e7f696cd8aa3110a0e637efad68475b50b14dc20f4418d5598af2c472a4b4e21388780d4d60b03f34c4a6e3d8b"} 08:22:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:41 INFO - Contents: 08:22:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3b143c6ab5b601fe96e8d3449640e9e86233825aef866967b794a2661514bce45b21ce6e2657475d1101cbe73ba1b57d9920c6f7eef6b96857a10158bcbdafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/101dd47b65bebcf115b98c3e14e5668957a92c65b559664202b6a357653c2937e7b2a9eb66fcebe16eb74df99c1e32cd4a65a2a798df38730d9dbd1977a0687e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add8838ffaab65236d44e2ae5f2b1402fc55f9e7f696cd8aa3110a0e637efad68475b50b14dc20f4418d5598af2c472a4b4e21388780d4d60b03f34c4a6e3d8b"} 08:22:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:41 INFO - Copying logs to upload dir... 08:22:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.307842 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-30 08:22:41.515924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 08:22:41.521973) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3b143c6ab5b601fe96e8d3449640e9e86233825aef866967b794a2661514bce45b21ce6e2657475d1101cbe73ba1b57d9920c6f7eef6b96857a10158bcbdafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/101dd47b65bebcf115b98c3e14e5668957a92c65b559664202b6a357653c2937e7b2a9eb66fcebe16eb74df99c1e32cd4a65a2a798df38730d9dbd1977a0687e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add8838ffaab65236d44e2ae5f2b1402fc55f9e7f696cd8aa3110a0e637efad68475b50b14dc20f4418d5598af2c472a4b4e21388780d4d60b03f34c4a6e3d8b"} build_url:https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/JqWGD9KRR0-HpQ9huLhXbQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3b143c6ab5b601fe96e8d3449640e9e86233825aef866967b794a2661514bce45b21ce6e2657475d1101cbe73ba1b57d9920c6f7eef6b96857a10158bcbdafb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/101dd47b65bebcf115b98c3e14e5668957a92c65b559664202b6a357653c2937e7b2a9eb66fcebe16eb74df99c1e32cd4a65a2a798df38730d9dbd1977a0687e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/add8838ffaab65236d44e2ae5f2b1402fc55f9e7f696cd8aa3110a0e637efad68475b50b14dc20f4418d5598af2c472a4b4e21388780d4d60b03f34c4a6e3d8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 08:22:41.547633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:22:41.547988) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467297322.104129-1456606928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:22:41.630521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 08:22:41.630859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 08:22:41.631162) ========= ========= Total master_lag: 0.18 =========