builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1467883445.48 results: success (0) buildid: 20160706234234 builduid: d64e2c98f5ce40b383b489354af69536 revision: b9cc2dcbf436 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.478381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.478752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.479023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.573984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.574256) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 02:24:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-07 02:24:05 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.743561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.743841) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.792467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:05.792771) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9cc2dcbf436 --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 b9cc2dcbf436 --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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 02:24:06,026 Setting DEBUG logging. 2016-07-07 02:24:06,026 attempt 1/10 2016-07-07 02:24:06,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9cc2dcbf436?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 02:24:06,333 unpacking tar archive at: fx-team-b9cc2dcbf436/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:06.437264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:06.437555) ========= script_repo_revision: b9cc2dcbf436 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:06.437961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:06.438279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:24:06.457278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-07 02:24:06.457571) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:06 INFO - MultiFileLogger online at 20160707 02:24:06 in /builds/slave/test 02:24:06 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 02:24:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:06 INFO - {'append_to_log': False, 02:24:06 INFO - 'base_work_dir': '/builds/slave/test', 02:24:06 INFO - 'blob_upload_branch': 'Fx-Team', 02:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:06 INFO - 'branch': 'Fx-Team', 02:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:06 INFO - 'config_files': ('talos/linux_config.py',), 02:24:06 INFO - 'default_actions': ('clobber', 02:24:06 INFO - 'read-buildbot-config', 02:24:06 INFO - 'download-and-extract', 02:24:06 INFO - 'populate-webroot', 02:24:06 INFO - 'create-virtualenv', 02:24:06 INFO - 'install', 02:24:06 INFO - 'run-tests'), 02:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:06 INFO - 'download_minidump_stackwalk': True, 02:24:06 INFO - 'download_symbols': 'ondemand', 02:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:06 INFO - 'installer_path': 'installer.exe', 02:24:06 INFO - 'log_level': 'info', 02:24:06 INFO - 'log_name': 'talos', 02:24:06 INFO - 'log_to_console': True, 02:24:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:06 INFO - 'opt_config_files': (), 02:24:06 INFO - 'pip_index': False, 02:24:06 INFO - 'sps_profile': False, 02:24:06 INFO - 'sps_profile_interval': 0, 02:24:06 INFO - 'suite': 'dromaeojs', 02:24:06 INFO - 'system_bits': '32', 02:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:06 INFO - 'title': 'talos-linux64-ix-062', 02:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:06 INFO - 'use_talos_json': True, 02:24:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:06 INFO - 'work_dir': 'build'} 02:24:06 INFO - ##### 02:24:06 INFO - ##### Running clobber step. 02:24:06 INFO - ##### 02:24:06 INFO - Running pre-action listener: _resource_record_pre_action 02:24:06 INFO - Running main action method: clobber 02:24:06 INFO - rmtree: /builds/slave/test/build 02:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:07 INFO - Running post-action listener: _resource_record_post_action 02:24:07 INFO - ##### 02:24:07 INFO - ##### Finished clobber step (success) 02:24:07 INFO - ##### 02:24:07 INFO - ##### 02:24:07 INFO - ##### Running read-buildbot-config step. 02:24:07 INFO - ##### 02:24:07 INFO - Running pre-action listener: _resource_record_pre_action 02:24:07 INFO - Running main action method: read_buildbot_config 02:24:07 INFO - Using buildbot properties: 02:24:07 INFO - { 02:24:07 INFO - "project": "", 02:24:07 INFO - "product": "firefox", 02:24:07 INFO - "script_repo_revision": "production", 02:24:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:24:07 INFO - "repository": "", 02:24:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:24:07 INFO - "buildid": "20160706234234", 02:24:07 INFO - "pgo_build": "True", 02:24:07 INFO - "basedir": "/builds/slave/test", 02:24:07 INFO - "buildnumber": 1313, 02:24:07 INFO - "slavename": "talos-linux64-ix-062", 02:24:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:24:07 INFO - "platform": "ubuntu64_hw", 02:24:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:24:07 INFO - "branch": "fx-team", 02:24:07 INFO - "repo_path": "integration/fx-team", 02:24:07 INFO - "revision": "b9cc2dcbf436", 02:24:07 INFO - "stage_platform": "linux64-pgo", 02:24:07 INFO - "builduid": "d64e2c98f5ce40b383b489354af69536", 02:24:07 INFO - "slavebuilddir": "test" 02:24:07 INFO - } 02:24:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:24:07 INFO - Running post-action listener: _resource_record_post_action 02:24:07 INFO - ##### 02:24:07 INFO - ##### Finished read-buildbot-config step (success) 02:24:07 INFO - ##### 02:24:07 INFO - ##### 02:24:07 INFO - ##### Running download-and-extract step. 02:24:07 INFO - ##### 02:24:07 INFO - Running pre-action listener: _resource_record_pre_action 02:24:07 INFO - Running main action method: download_and_extract 02:24:07 INFO - mkdir: /builds/slave/test/build/tests 02:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:07 INFO - https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:11 INFO - Downloaded 1361 bytes. 02:24:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:11 INFO - Using the following test package requirements: 02:24:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'jsshell-linux-x86_64.zip'], 02:24:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24: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')]} 02:24:11 INFO - https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:17 INFO - Downloaded 24302895 bytes. 02:24:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:18 INFO - Return code: 0 02:24:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:18 INFO - https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:22 INFO - Downloaded 24302895 bytes. 02:24:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:24 INFO - Return code: 0 02:24: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')]} 02:24:24 INFO - https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:24:25 INFO - Downloaded 14403333 bytes. 02:24:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:24:26 INFO - Return code: 0 02:24: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')]} 02:24:26 INFO - https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:24:27 INFO - Downloaded 60384994 bytes. 02:24:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:24:27 INFO - mkdir: /builds/slave/test/properties 02:24:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:24:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:24:27 INFO - Contents: 02:24:27 INFO - build_url:https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:24:28 INFO - Running post-action listener: _resource_record_post_action 02:24:28 INFO - Running post-action listener: set_extra_try_arguments 02:24:28 INFO - ##### 02:24:28 INFO - ##### Finished download-and-extract step (success) 02:24:28 INFO - ##### 02:24:28 INFO - ##### 02:24:28 INFO - ##### Running populate-webroot step. 02:24:28 INFO - ##### 02:24:28 INFO - Running pre-action listener: _resource_record_pre_action 02:24:28 INFO - Running main action method: populate_webroot 02:24:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:28 INFO - '--tppagecycles', 02:24:28 INFO - '7'], 02:24:28 INFO - 'tests': ['tsvgm']}}, 02:24:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:24:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:24:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['damp', 'tps']}, 02:24:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'tests': ['damp', 'tps']}, 02:24:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['dromaeo_dom']}, 02:24:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['basic_compositor_video']}, 02:24:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:24:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['a11yr', 02:24:28 INFO - 'ts_paint', 02:24:28 INFO - 'tpaint', 02:24:28 INFO - 'sessionrestore', 02:24:28 INFO - 'sessionrestore_no_auto_restore', 02:24:28 INFO - 'tabpaint']}, 02:24:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['tsvgx', 02:24:28 INFO - 'tsvgr_opacity', 02:24:28 INFO - 'tart', 02:24:28 INFO - 'tscrollx', 02:24:28 INFO - 'cart']}, 02:24:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:24:28 INFO - 'tsvgr_opacity', 02:24:28 INFO - 'tart', 02:24:28 INFO - 'tscrollx', 02:24:28 INFO - 'cart']}, 02:24:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'talos_options': ['--disable-e10s'], 02:24:28 INFO - 'tests': ['tp5o']}, 02:24:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'tests': ['tp5o']}, 02:24:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'talos_options': ['--disable-e10s', 02:24:28 INFO - '--xperf_path', 02:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:28 INFO - 'tests': ['tp5n']}, 02:24:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:28 INFO - 'talos_options': ['--xperf_path', 02:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:28 INFO - 'tests': ['tp5n']}}, 02:24:28 INFO - 'talos.zip': {'path': '', 02:24:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:28 INFO - Running post-action listener: _resource_record_post_action 02:24:28 INFO - ##### 02:24:28 INFO - ##### Finished populate-webroot step (success) 02:24:28 INFO - ##### 02:24:28 INFO - ##### 02:24:28 INFO - ##### Running create-virtualenv step. 02:24:28 INFO - ##### 02:24:28 INFO - Running pre-action listener: _resource_record_pre_action 02:24:28 INFO - Running main action method: create_virtualenv 02:24:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:24:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:24:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:28 INFO - Using real prefix '/usr' 02:24:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:30 INFO - Installing pip.................done. 02:24:30 INFO - Return code: 0 02:24:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:30 INFO - Using env: {'DISPLAY': ':0', 02:24:30 INFO - 'HOME': '/home/cltbld', 02:24:30 INFO - 'LANG': 'en_US.UTF-8', 02:24:30 INFO - 'LANGUAGE': 'en_US:en', 02:24:30 INFO - 'LOGNAME': 'cltbld', 02:24:30 INFO - 'MAIL': '/var/mail/cltbld', 02:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:30 INFO - 'MOZ_NO_REMOTE': '1', 02:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:30 INFO - 'NO_EM_RESTART': '1', 02:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:30 INFO - 'PWD': '/builds/slave/test', 02:24:30 INFO - 'SHELL': '/bin/bash', 02:24:30 INFO - 'SHLVL': '1', 02:24:30 INFO - 'TERM': 'linux', 02:24:30 INFO - 'TMOUT': '86400', 02:24:30 INFO - 'USER': 'cltbld', 02:24:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:30 INFO - '_': '/tools/buildbot/bin/python'} 02:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:24:30 INFO - Cleaning up... 02:24:30 INFO - Return code: 0 02:24:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:24:30 INFO - Using env: {'DISPLAY': ':0', 02:24:30 INFO - 'HOME': '/home/cltbld', 02:24:30 INFO - 'LANG': 'en_US.UTF-8', 02:24:30 INFO - 'LANGUAGE': 'en_US:en', 02:24:30 INFO - 'LOGNAME': 'cltbld', 02:24:30 INFO - 'MAIL': '/var/mail/cltbld', 02:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:30 INFO - 'MOZ_NO_REMOTE': '1', 02:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:30 INFO - 'NO_EM_RESTART': '1', 02:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:30 INFO - 'PWD': '/builds/slave/test', 02:24:30 INFO - 'SHELL': '/bin/bash', 02:24:30 INFO - 'SHLVL': '1', 02:24:30 INFO - 'TERM': 'linux', 02:24:30 INFO - 'TMOUT': '86400', 02:24:30 INFO - 'USER': 'cltbld', 02:24:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:30 INFO - '_': '/tools/buildbot/bin/python'} 02:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:31 INFO - Downloading/unpacking psutil>=3.1.1 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24: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 02:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:33 INFO - Installing collected packages: psutil 02:24:33 INFO - Running setup.py install for psutil 02:24:33 INFO - building 'psutil._psutil_linux' extension 02:24:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:24:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:24:33 INFO - building 'psutil._psutil_posix' extension 02:24:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:24:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:33 INFO - Successfully installed psutil 02:24:33 INFO - Cleaning up... 02:24:33 INFO - Return code: 0 02:24:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:33 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:24:33 INFO - Using env: {'DISPLAY': ':0', 02:24:33 INFO - 'HOME': '/home/cltbld', 02:24:33 INFO - 'LANG': 'en_US.UTF-8', 02:24:33 INFO - 'LANGUAGE': 'en_US:en', 02:24:33 INFO - 'LOGNAME': 'cltbld', 02:24:33 INFO - 'MAIL': '/var/mail/cltbld', 02:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:33 INFO - 'MOZ_NO_REMOTE': '1', 02:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:33 INFO - 'NO_EM_RESTART': '1', 02:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:33 INFO - 'PWD': '/builds/slave/test', 02:24:33 INFO - 'SHELL': '/bin/bash', 02:24:33 INFO - 'SHLVL': '1', 02:24:33 INFO - 'TERM': 'linux', 02:24:33 INFO - 'TMOUT': '86400', 02:24:33 INFO - 'USER': 'cltbld', 02:24:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:33 INFO - '_': '/tools/buildbot/bin/python'} 02:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:35 INFO - Installing collected packages: mozsystemmonitor 02:24:35 INFO - Running setup.py install for mozsystemmonitor 02:24:36 INFO - Successfully installed mozsystemmonitor 02:24:36 INFO - Cleaning up... 02:24:36 INFO - Return code: 0 02:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:24:36 INFO - Using env: {'DISPLAY': ':0', 02:24:36 INFO - 'HOME': '/home/cltbld', 02:24:36 INFO - 'LANG': 'en_US.UTF-8', 02:24:36 INFO - 'LANGUAGE': 'en_US:en', 02:24:36 INFO - 'LOGNAME': 'cltbld', 02:24:36 INFO - 'MAIL': '/var/mail/cltbld', 02:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:36 INFO - 'MOZ_NO_REMOTE': '1', 02:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:36 INFO - 'NO_EM_RESTART': '1', 02:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:36 INFO - 'PWD': '/builds/slave/test', 02:24:36 INFO - 'SHELL': '/bin/bash', 02:24:36 INFO - 'SHLVL': '1', 02:24:36 INFO - 'TERM': 'linux', 02:24:36 INFO - 'TMOUT': '86400', 02:24:36 INFO - 'USER': 'cltbld', 02:24:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:36 INFO - '_': '/tools/buildbot/bin/python'} 02:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:38 INFO - warning: no files found matching '*.txt' 02:24:38 INFO - no previously-included directories found matching 'build' 02:24:38 INFO - no previously-included directories found matching 'dist' 02:24:38 INFO - no previously-included directories found matching '.git*' 02:24:38 INFO - Installing collected packages: jsonschema, functools32 02:24:38 INFO - Running setup.py install for functools32 02:24:38 INFO - warning: no files found matching '*.txt' 02:24:38 INFO - no previously-included directories found matching 'build' 02:24:38 INFO - no previously-included directories found matching 'dist' 02:24:38 INFO - no previously-included directories found matching '.git*' 02:24:38 INFO - Successfully installed jsonschema functools32 02:24:38 INFO - Cleaning up... 02:24:38 INFO - Return code: 0 02:24:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:38 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:24:38 INFO - Using env: {'DISPLAY': ':0', 02:24:38 INFO - 'HOME': '/home/cltbld', 02:24:38 INFO - 'LANG': 'en_US.UTF-8', 02:24:38 INFO - 'LANGUAGE': 'en_US:en', 02:24:38 INFO - 'LOGNAME': 'cltbld', 02:24:38 INFO - 'MAIL': '/var/mail/cltbld', 02:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:38 INFO - 'MOZ_NO_REMOTE': '1', 02:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:38 INFO - 'NO_EM_RESTART': '1', 02:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:38 INFO - 'PWD': '/builds/slave/test', 02:24:38 INFO - 'SHELL': '/bin/bash', 02:24:38 INFO - 'SHLVL': '1', 02:24:38 INFO - 'TERM': 'linux', 02:24:38 INFO - 'TMOUT': '86400', 02:24:38 INFO - 'USER': 'cltbld', 02:24:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:38 INFO - '_': '/tools/buildbot/bin/python'} 02:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:40 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:41 INFO - Downloading docopt-0.6.1.tar.gz 02:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:41 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:41 INFO - Running setup.py install for blobuploader 02:24:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:41 INFO - Running setup.py install for requests 02:24:41 INFO - Running setup.py install for docopt 02:24:42 INFO - Successfully installed blobuploader requests docopt 02:24:42 INFO - Cleaning up... 02:24:42 INFO - Return code: 0 02:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:42 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:42 INFO - Using env: {'DISPLAY': ':0', 02:24:42 INFO - 'HOME': '/home/cltbld', 02:24:42 INFO - 'LANG': 'en_US.UTF-8', 02:24:42 INFO - 'LANGUAGE': 'en_US:en', 02:24:42 INFO - 'LOGNAME': 'cltbld', 02:24:42 INFO - 'MAIL': '/var/mail/cltbld', 02:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:42 INFO - 'MOZ_NO_REMOTE': '1', 02:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:42 INFO - 'NO_EM_RESTART': '1', 02:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:42 INFO - 'PWD': '/builds/slave/test', 02:24:42 INFO - 'SHELL': '/bin/bash', 02:24:42 INFO - 'SHLVL': '1', 02:24:42 INFO - 'TERM': 'linux', 02:24:42 INFO - 'TMOUT': '86400', 02:24:42 INFO - 'USER': 'cltbld', 02:24:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:42 INFO - '_': '/tools/buildbot/bin/python'} 02:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:42 INFO - Running setup.py (path:/tmp/pip-ru6x5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:42 INFO - Running setup.py (path:/tmp/pip-MDMWQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:42 INFO - Running setup.py (path:/tmp/pip-vYZM39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:42 INFO - Running setup.py (path:/tmp/pip-HIrfU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:42 INFO - Running setup.py (path:/tmp/pip-oLPPXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:42 INFO - Running setup.py (path:/tmp/pip-t958Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:42 INFO - Running setup.py (path:/tmp/pip-6qSmQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:42 INFO - Running setup.py (path:/tmp/pip-Y6fcp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:42 INFO - Running setup.py (path:/tmp/pip-ivdnis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:43 INFO - Running setup.py (path:/tmp/pip-IOHR3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:43 INFO - Running setup.py (path:/tmp/pip-g28KcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:43 INFO - Running setup.py (path:/tmp/pip-WsvXxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:43 INFO - Running setup.py (path:/tmp/pip-FjrzXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:43 INFO - Running setup.py (path:/tmp/pip-PL42kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:43 INFO - Running setup.py (path:/tmp/pip-eHhbiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:43 INFO - Running setup.py (path:/tmp/pip-BPesL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:43 INFO - Running setup.py (path:/tmp/pip-L4Pm_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:43 INFO - Running setup.py install for manifestparser 02:24:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:43 INFO - Running setup.py install for mozcrash 02:24:43 INFO - Running setup.py install for mozdebug 02:24:43 INFO - Running setup.py install for mozdevice 02:24:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for mozfile 02:24:44 INFO - Running setup.py install for mozhttpd 02:24:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for mozinfo 02:24:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for mozInstall 02:24:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for mozleak 02:24:44 INFO - Running setup.py install for mozlog 02:24:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for moznetwork 02:24:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Running setup.py install for mozprocess 02:24:44 INFO - Running setup.py install for mozprofile 02:24:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:24:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:24:45 INFO - Running setup.py install for mozrunner 02:24:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:24:45 INFO - Running setup.py install for mozscreenshot 02:24:45 INFO - Running setup.py install for moztest 02:24:45 INFO - Running setup.py install for mozversion 02:24:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:24:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:45 INFO - Cleaning up... 02:24:45 INFO - Return code: 0 02:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:45 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:45 INFO - Using env: {'DISPLAY': ':0', 02:24:45 INFO - 'HOME': '/home/cltbld', 02:24:45 INFO - 'LANG': 'en_US.UTF-8', 02:24:45 INFO - 'LANGUAGE': 'en_US:en', 02:24:45 INFO - 'LOGNAME': 'cltbld', 02:24:45 INFO - 'MAIL': '/var/mail/cltbld', 02:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:45 INFO - 'MOZ_NO_REMOTE': '1', 02:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:45 INFO - 'NO_EM_RESTART': '1', 02:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:45 INFO - 'PWD': '/builds/slave/test', 02:24:45 INFO - 'SHELL': '/bin/bash', 02:24:45 INFO - 'SHLVL': '1', 02:24:45 INFO - 'TERM': 'linux', 02:24:45 INFO - 'TMOUT': '86400', 02:24:45 INFO - 'USER': 'cltbld', 02:24:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:45 INFO - '_': '/tools/buildbot/bin/python'} 02:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:45 INFO - Running setup.py (path:/tmp/pip-rzlb8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:45 INFO - Running setup.py (path:/tmp/pip-wWxfCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:45 INFO - Running setup.py (path:/tmp/pip-am3VsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:45 INFO - Running setup.py (path:/tmp/pip-dOR9EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:45 INFO - Running setup.py (path:/tmp/pip-D4yhks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:46 INFO - Running setup.py (path:/tmp/pip-bUg5Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:46 INFO - Running setup.py (path:/tmp/pip-6AqvgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:46 INFO - Running setup.py (path:/tmp/pip-STYHTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:46 INFO - Running setup.py (path:/tmp/pip-r0Ik5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:46 INFO - Running setup.py (path:/tmp/pip-p8bjwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:46 INFO - Running setup.py (path:/tmp/pip-i5o0q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:46 INFO - Running setup.py (path:/tmp/pip-aQqtmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:46 INFO - Running setup.py (path:/tmp/pip-64F9d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:46 INFO - Running setup.py (path:/tmp/pip-7lPW7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:46 INFO - Running setup.py (path:/tmp/pip-Tfwlet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:46 INFO - Running setup.py (path:/tmp/pip-tEGkFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:46 INFO - Running setup.py (path:/tmp/pip-SGUc0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:24:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:48 INFO - Downloading blessings-1.6.tar.gz 02:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:48 INFO - Installing collected packages: blessings 02:24:48 INFO - Running setup.py install for blessings 02:24:48 INFO - Successfully installed blessings 02:24:48 INFO - Cleaning up... 02:24:49 INFO - Return code: 0 02:24:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:49 INFO - Reading from file tmpfile_stdout 02:24:49 INFO - Current package versions: 02:24:49 INFO - argparse == 1.2.1 02:24:49 INFO - blessings == 1.6 02:24:49 INFO - blobuploader == 1.2.4 02:24:49 INFO - docopt == 0.6.1 02:24:49 INFO - functools32 == 3.2.3-2 02:24:49 INFO - jsonschema == 2.5.1 02:24:49 INFO - manifestparser == 1.1 02:24:49 INFO - mozInstall == 1.12 02:24:49 INFO - mozcrash == 0.17 02:24:49 INFO - mozdebug == 0.1 02:24:49 INFO - mozdevice == 0.48 02:24:49 INFO - mozfile == 1.2 02:24:49 INFO - mozhttpd == 0.7 02:24:49 INFO - mozinfo == 0.9 02:24:49 INFO - mozleak == 0.1 02:24:49 INFO - mozlog == 3.2 02:24:49 INFO - moznetwork == 0.27 02:24:49 INFO - mozprocess == 0.23 02:24:49 INFO - mozprofile == 0.28 02:24:49 INFO - mozrunner == 6.12 02:24:49 INFO - mozscreenshot == 0.1 02:24:49 INFO - mozsystemmonitor == 0.3 02:24:49 INFO - moztest == 0.7 02:24:49 INFO - mozversion == 1.4 02:24:49 INFO - psutil == 3.1.1 02:24:49 INFO - requests == 1.2.3 02:24:49 INFO - wsgiref == 0.1.2 02:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:49 INFO - Using env: {'DISPLAY': ':0', 02:24:49 INFO - 'HOME': '/home/cltbld', 02:24:49 INFO - 'LANG': 'en_US.UTF-8', 02:24:49 INFO - 'LANGUAGE': 'en_US:en', 02:24:49 INFO - 'LOGNAME': 'cltbld', 02:24:49 INFO - 'MAIL': '/var/mail/cltbld', 02:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:49 INFO - 'MOZ_NO_REMOTE': '1', 02:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:49 INFO - 'NO_EM_RESTART': '1', 02:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:49 INFO - 'PWD': '/builds/slave/test', 02:24:49 INFO - 'SHELL': '/bin/bash', 02:24:49 INFO - 'SHLVL': '1', 02:24:49 INFO - 'TERM': 'linux', 02:24:49 INFO - 'TMOUT': '86400', 02:24:49 INFO - 'USER': 'cltbld', 02:24:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:49 INFO - '_': '/tools/buildbot/bin/python'} 02:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:24:49 INFO - Cleaning up... 02:24:49 INFO - Return code: 0 02:24:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 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 0x1b93030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e54180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:24:49 INFO - Using env: {'DISPLAY': ':0', 02:24:49 INFO - 'HOME': '/home/cltbld', 02:24:49 INFO - 'LANG': 'en_US.UTF-8', 02:24:49 INFO - 'LANGUAGE': 'en_US:en', 02:24:49 INFO - 'LOGNAME': 'cltbld', 02:24:49 INFO - 'MAIL': '/var/mail/cltbld', 02:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:49 INFO - 'MOZ_NO_REMOTE': '1', 02:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:49 INFO - 'NO_EM_RESTART': '1', 02:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:49 INFO - 'PWD': '/builds/slave/test', 02:24:49 INFO - 'SHELL': '/bin/bash', 02:24:49 INFO - 'SHLVL': '1', 02:24:49 INFO - 'TERM': 'linux', 02:24:49 INFO - 'TMOUT': '86400', 02:24:49 INFO - 'USER': 'cltbld', 02:24:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:49 INFO - '_': '/tools/buildbot/bin/python'} 02:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:24:49 INFO - Cleaning up... 02:24:49 INFO - Return code: 0 02:24:49 INFO - Running post-action listener: _resource_record_post_action 02:24:49 INFO - Running post-action listener: _start_resource_monitoring 02:24:49 INFO - Starting resource monitoring. 02:24:49 INFO - ##### 02:24:49 INFO - ##### Finished create-virtualenv step (success) 02:24:49 INFO - ##### 02:24:49 INFO - ##### 02:24:49 INFO - ##### Running install step. 02:24:49 INFO - ##### 02:24:49 INFO - Running pre-action listener: _resource_record_pre_action 02:24:49 INFO - Running main action method: install 02:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:49 INFO - Reading from file tmpfile_stdout 02:24:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:24:50 INFO - Reading from file tmpfile_stdout 02:24:50 INFO - Output received: 02:24:50 INFO - Usage: mozinstall [options] installer 02:24:50 INFO - Options: 02:24:50 INFO - -h, --help show this help message and exit 02:24:50 INFO - -d DEST, --destination=DEST 02:24:50 INFO - Directory to install application into. [default: 02:24:50 INFO - "/builds/slave/test"] 02:24:50 INFO - --app=APP Application being installed. [default: firefox] 02:24:50 INFO - mkdir: /builds/slave/test/build/application 02:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:25:07 INFO - Reading from file tmpfile_stdout 02:25:07 INFO - Output received: 02:25:07 INFO - /builds/slave/test/build/application/firefox/firefox 02:25:07 INFO - Running post-action listener: _resource_record_post_action 02:25:07 INFO - ##### 02:25:07 INFO - ##### Finished install step (success) 02:25:07 INFO - ##### 02:25:07 INFO - ##### 02:25:07 INFO - ##### Running run-tests step. 02:25:07 INFO - ##### 02:25:07 INFO - Running pre-action listener: _resource_record_pre_action 02:25:07 INFO - Running main action method: run_tests 02:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:25:07 INFO - Python 2.7.3 02:25:07 INFO - Return code: 0 02:25:07 INFO - grabbing minidump binary from tooltool 02:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:07 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 0x1e523b0>, '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 0x1e532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e53740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:25:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:25:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:25:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:25:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:07 INFO - Return code: 0 02:25:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:25:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:25:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:25:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:25:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:25:07 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/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 02:25:07 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/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 02:25:07 INFO - Using env: {'DISPLAY': ':0', 02:25:07 INFO - 'HOME': '/home/cltbld', 02:25:07 INFO - 'LANG': 'en_US.UTF-8', 02:25:07 INFO - 'LANGUAGE': 'en_US:en', 02:25:07 INFO - 'LOGNAME': 'cltbld', 02:25:07 INFO - 'MAIL': '/var/mail/cltbld', 02:25:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:07 INFO - 'MOZ_NO_REMOTE': '1', 02:25:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:07 INFO - 'NO_EM_RESTART': '1', 02:25:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:07 INFO - 'PWD': '/builds/slave/test', 02:25:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:07 INFO - 'SHELL': '/bin/bash', 02:25:07 INFO - 'SHLVL': '1', 02:25:07 INFO - 'TERM': 'linux', 02:25:07 INFO - 'TMOUT': '86400', 02:25:07 INFO - 'USER': 'cltbld', 02:25:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619', 02:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:07 INFO - '_': '/tools/buildbot/bin/python'} 02:25:07 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/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 02:25:07 INFO - mozversion application_buildid: 20160706234234 02:25:07 INFO - mozversion application_changeset: b9cc2dcbf4363c8049183110fe79e026fae87ecb 02:25:07 INFO - mozversion application_display_name: Nightly 02:25:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:07 INFO - mozversion application_name: Firefox 02:25:07 INFO - mozversion application_remotingname: firefox 02:25:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:25:07 INFO - mozversion application_vendor: Mozilla 02:25:07 INFO - mozversion application_version: 50.0a1 02:25:07 INFO - mozversion platform_buildid: 20160706234234 02:25:07 INFO - mozversion platform_changeset: b9cc2dcbf4363c8049183110fe79e026fae87ecb 02:25:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:25:07 INFO - mozversion platform_version: 50.0a1 02:25:07 INFO - using testdate: 1467883507 02:25:07 INFO - actual date: 1467883507 02:25:07 INFO - starting webserver on 'localhost:48864' 02:25:07 INFO - SUITE-START | Running 2 tests 02:25:07 INFO - TEST-START | dromaeo_css 02:25:07 INFO - operating with platform_type : linux_ 02:25:07 INFO - Initialising browser for dromaeo_css test... 02:25:07 INFO - TEST-INFO | started process 18306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqhBD9/profile http://localhost:48864/getInfo.html) 02:25:11 INFO - PROCESS | 18306 | __metrics Screen width/height:1600/1200 02:25:11 INFO - PROCESS | 18306 | colorDepth:24 02:25:11 INFO - PROCESS | 18306 | Browser inner width/height: 1024/697 02:25:11 INFO - PROCESS | 18306 | __metrics 02:25:12 INFO - PROCESS | 18306 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:13 INFO - TEST-INFO | 18306: exit 0 02:25:13 INFO - Browser initialized. 02:25:13 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:13 INFO - TEST-INFO | started process 18386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqhBD9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:25 INFO - PROCESS | 18386 | RSS: Main: 157249536 02:25:25 INFO - PROCESS | 18386 | 02:26:15 INFO - PROCESS | 18386 | 1467883575761 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:28:24 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48864/tests/dromaeo/cssquery-ext.html) 02:28:25 INFO - PROCESS | 18386 | RSS: Main: 258002944 02:28:25 INFO - PROCESS | 18386 | 02:31:28 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-ext.html (next: http://localhost:48864/tests/dromaeo/cssquery-jquery.html) 02:31:28 INFO - PROCESS | 18386 | RSS: Main: 240414720 02:31:28 INFO - PROCESS | 18386 | 02:34:30 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48864/tests/dromaeo/cssquery-mootools.html) 02:34:31 INFO - PROCESS | 18386 | RSS: Main: 242257920 02:34:31 INFO - PROCESS | 18386 | 02:37:33 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48864/tests/dromaeo/cssquery-prototype.html) 02:37:34 INFO - PROCESS | 18386 | RSS: Main: 239333376 02:37:34 INFO - PROCESS | 18386 | 02:40:36 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48864/tests/dromaeo/cssquery-yui.html) 02:40:37 INFO - PROCESS | 18386 | RSS: Main: 225660928 02:40:37 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | Cycle 1(1): loaded http://localhost:48864/tests/dromaeo/cssquery-yui.html (next: http://localhost:48864/tests/dromaeo/cssquery-dojo.html) 02:43:40 INFO - PROCESS | 18386 | RSS: Main: 300564480 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | __start_tp_report 02:43:40 INFO - PROCESS | 18386 | _x_x_mozilla_page_load 02:43:40 INFO - PROCESS | 18386 | _x_x_mozilla_page_load_details 02:43:40 INFO - PROCESS | 18386 | |i|pagename|runs| 02:43:40 INFO - PROCESS | 18386 | |0;dojo.html;3086.089603566948;3086.6141732283463;3095.117891400951;3120.032789835151;3125.8280794556304;5221.164613661815;5313.814016509423;5318.202269659549;5433.130699088147;5453.509184173424;5382.4886635769635;5400.621956463049;5410.810621628244;5418.4039755626945;5424.891502169954;4845.830395936134;4894.583960363373;4923.187674033798;4944.53026962438;5051.696898186102;4944.233643785219;4944.283078953567;4993.901341704837;5000.174971129777;5014.84955451337;4731.5268473152755;4779.498152693969;4850.151223535902;4861.805527778884;4867.853964381075;4785.880352991168;4829.3480380148585;4885.7068575885205;4895.290182923492;4943.233798761198;4743.478217396084;4851.345068415754;4852.927206091911;4899.951000489985;4926.285688575136;5305.602079843989;5391.137418013099;5407.540359069484;5473.233747275384;5478.233047373371;5835.766569337221;5856.941430585724;5860.560457965669;5874.441928016831;5876.2067120938555;5565.499105080562;5640.464155905182;5746.36789953109;5918.704064796743;5928;5522.91715624266;5550.084236101038;5551.694656793915;5557.499825015768;5574.693391863446;6029.638221706711;6031.5476339273855;6041.852048110845;6043.244594425697;6044.063170208625;5501.752421141058;5633.492985631313;5684.772609095672;5704.315482142087;5812.912806307909;5852.005159122959;5857.648541087548;5864.941350586525;5882.794102206402;5885.47030767233;5699.031164702011;5702.714864256771;5715.428457154251;5720.628159169641;5721.256236689287;5520.613557050968;5686.60193786431;5699.316082070178;5746.13807928814;5801.970990145022;4401.955980440219;4415.757133357632;4416.580424859633;4417.558244175557;4455.866324010285;3882.883513494543;3943.645071943539;3951.1110000249714;3968.0278331808313;3975.6223158799867;5288.471152884757;5402.648827826179;5436.238926550286;5466.562674985991;5494.011078005998;5853.385394533512;5866.208061911588;5868.471837534557;5871.4128587141795;5911.556633252438;5290.338707661543;5510.256115424447;5512.5589952803675;5514.80698175562;5520.089185284383;4893.535114164149;4957.03337849116;4961.82633607822;4994.575461085776;5012.147934851084;5901.881962360814;5906.527477801766;5910.940890591039;5912.556558258148;5923.437273459014;5608.495235428831;5717.028105222039;5784.4504772046585;5803.636145505719;5806.2451881255165;5901.527877769854;5951.464368206709;5955.970220148872;5963.642181469126;5975.312839023568;5696.572757043155;5705.144228365778;5706.600537962303;5712;5713.542916566582;5570.944290557042;5695.629784064023;5734.741936612946;5762.337331206965;5788.044972579645;5643.492085712305;5649.067903795828;5653.632513886584;5656.717164141694;5701.6864072474755;5579.12021947389;5628.718564071862;5637.661740295595;5641;5648.4633959773755;5432.429594892479;5534.7509362078;5544.473275038865;5569.164625306236;5590.776368945197;5669.6314739541795;5675.631083979528;5680.943190568041;5731.828045158652;5736.627119237236;5570.997220500349;5573.442655734556;5573.721313934206;5574.9442505574425;5582.748776304995 02:43:40 INFO - PROCESS | 18386 | |1;ext.html;586.6626689653448;608.2214765100671;617.1853153836935;641.5605310362403;645.0356716708521;43779.467718629814;44925.32612010823;44939.55060449395;44958.55041449588;49164.75417622916;46489;47169;47177.29234061483;47181.52818471814;47315.290270645964;9025.684101056464;9156.679516216935;9157.679481218158;9170.862437063415;9178.173964343208;9043.412178208395;9132.452052876815;9139.95430022849;9147.771305717344;9152.039035901234;9166.220871225954;9193.862092068624;9209.677661281856;9213.355065145442;9216.861747073799;9070.27437804974;9133.17801397874;9137.634494620208;9138.85764279465;9153.496557689292;8907.242884354837;9064.728058158265;9066.229370503515;9069.501177435239;9075.81848363029;44312.77843610761;44920.775396123136;44943;44944.28085051088;44944.550554494366;3570.7500474966764;3697.815109244527;3705.907352316187;3736.5889752127246;4014.879553613396;33462.832685836416;34121.146971325914;34315.31369372624;35829.46255806165;35924.46113308302;3851.114243723931;3877.4571559981623;3932.58707835676;3934.1344904121047;4154.044569748944;252785;253883;254022;254071;254145;52800.207996880075;61173.69413152906;61988.69005654943;62052.68973655103;62108.68945655243;53451.73274133605;54571.45428545743;54599.727001364736;54637;54772;17340.65318693619;17445.30218791234;17492;17496.21267042986;17503;12352;12547.874521254671;13460.326983650779;13535;13565.660858478617;16880.396362345557;18123.275068997093;18197.636047279244;18245.452636420927;19290.807091929182;6496;6632.6352050636715;6645.667716614246;6886.931130688629;6941.826454338581;903.074348792493;942.1803031362622;1002.3484734922213;1008.3496144986443;1022.3916769522123;32754.344913101606;34392.46734433907;34507.482387764205;34592.308153836784;34801.65198348035;1123.2754873106965;1130.191912782348;1134.744682446443;1142.3888219802366;1163.168334640736;17324.39364622232;17815.198316075806;17840;17881.910590447224;17908.46274611764;615770;621478;622213;623532;627978;61809.381906180366;61829;61961;62473.37526624766;62506;1232.993835030837;1312.1077667186405;1322.9933850330688;1383.889288856889;1399.6500874781304;33216;34583.13542161466;34942.301153977285;35023.47464787979;35034.299314013064;51532.74233628808;52127;52482.73758631335;52587.73706131445;52674;447706;448410;449967;450153;453038;38369.61630383772;44481.33278000768;44692.10615787731;45103.09793804171;48625.270620940006;50176.498235017185;50708.492915070376;51107.744461277456;51255.74372128116;51737.223941641656;41917.37123943205;41919;42144.36783448312;43150.568494315914;43895;42279;42471.575284248;42520;42894.35658465063;43654;42884.35673464963;42918.141637167704;44708.32937505875;46635.30047049229;46828.29757553571;40786;45735.771321143184;45897.31154032626;47050.76474617605;47477.52522474731;34021;34922;35360.64639353574;35455.64544354523;35757.28485430329 02:43:40 INFO - PROCESS | 18386 | |2;jquery.html;367.78668372344043;390.19619583657686;392.3134514599451;392.82322954670406;415.63424186715685;14390.064645798016;16560.503184904457;19294.517637059045;19437.4168774937;19442.51393715158;18065.277388904462;18587.163577639007;18800.62398752024;18811.153498092586;18853.905730471364;4211.557786432427;5681.318241810978;5772.797952071678;5802.883942321172;5803.303603567578;6176.4749996250375;6518.054882042101;6534.24856141545;6604.075429439858;6613.735450581995;6279.780207692732;6473.773417930373;6487.351264873499;6540.37866402691;6580.769673061443;6242;6409.839754006164;6438.871222575545;6439.066335381391;6468.223813142429;5787.50806181475;5809.157672137559;5815.418458154193;5818.185454036438;5826.592138550303;23073.19243826458;23278.185263515865;23316.65025024626;23744.40638984039;23806.523869522513;2153.353993801853;2223.7998580127705;2253.1100215414817;2337.567550003255;2597.7012643546045;9345.953270233606;9464.95267523658;9539.809203815954;9696.17582505488;10032.749181270454;1895.75355203824;1966.8721533100445;1976.762788465379;1993.1130646862152;2023.1603884387962;82847;83289;83811.5809420955;89199.55400222958;89227;9364.95317523408;9977;10930.398828064534;10974.561017559368;11092.667219983414;15069.849301506845;15188.696226075417;15209.163496007604;15215.087094774128;15234.466793662168;8286.337093032544;8407.2433480987;8453.577321133918;8621.224089831945;8635;8306.418550701514;8324.916750832414;8365.665373384996;8468.44955077918;8523.275521580612;4445.955540444619;4499.100179963955;4529.343245229489;4617.168909596305;4753.762311884392;1927.6530224559715;1963.9312624058375;1974.4854159595943;1999.3602047345;2022.5247066939257;875.4747151708924;959.4291396619001;988.728099772554;1041.7916416716687;1099.6975831646362;18810.52973675669;19699.507512312306;19743.111559979836;19782.40652780419;19788.70316945247;968.8498282766183;998.9750256243652;1010.5654568535454;1011.1708399112804;1016.202281209262;10320.329178603366;10671.519781609846;10981.12151027916;10987.780244395068;10989.505472253768;315618;320427;323214;324115;387427;71786.282137179;72221.63889180521;82692.17307826965;91786.54106729424;96415;952.2667545989549;973.8928717841031;1003.1072345612411;1003.4781913405135;1007.6674697349857;17305.13474326304;17420.30318787234;17678.204480798137;17707.645847083244;17727;42789.78605106955;44049.779751102324;44264;44591.77704111459;45837.77081114573;57826.4217357821;58557.4144258552;59302.40697592969;59380;60663.69668151631;7547.5848828314965;7614.771556853303;7622.466427350254;8052.194780521901;8244.876326854983;9386.577604007973;12864.421101050288;13479.865201348253;13736;14151.363188656329;12102.092343074128;12267.325297108744;12289.201201921847;12316.753664926471;12428.689282768004;11812.114091443347;12039.518419263131;12086.939565302117;12110.212836165621;12177.695557610776;12090.75818483643;12236.694082648006;12505.187162834387;12534.615653773613;12802.551910683082;7958.482698624571;7993.72021979228;8114.43198976066;8172.5913704315735;8260.545669988209;9760.56077476501;11696.88303116958;11851.644450666494;11874.643760687193;11975.221610595632 02:43:40 INFO - PROCESS | 18386 | |3;mootools.html;1443.364919435448;1489.5233525271915;1579.2893198060876;1708.2569082449143;1723.2503860820543;8489.575521223946;9015.233705135071;9078.2283505902;9084.50035248061;9104.590293436802;7453.590052547108;8376.748697539084;8617.741467755977;8629.223369896708;8835.425697329685;2311.6648086027517;2339.6607491913664;2341.3678306857137;2341.695579574661;2341.906323747048;2308.746037935826;2324.976750232501;2326.3718795925092;2328.860268383902;2333.0434521846046;2015.9899200503976;2083.541620843412;2087.634663933813;2090.1848279171136;2209.4807720185745;2266.9319920402413;2303.4702018535663;2304.2396009316885;2309.2956648222284;2314.25943698015;2283.5775381554467;2284.565932472825;2324.070371851256;2324.97675023251;2325.8255630827757;8889;8921.420107692978;8931.86602200961;8935.64257429702;8951.820963580692;4983.975080124576;5122.3853137623355;5136.74316284188;5154.433012368637;5167.250748641463;3323.2854936188837;3392.9660703392897;3401.48977653354;3401.710854577364;3410.488426735985;1132.2753437799815;1154.8614166300015;1172.7595842852195;1187.1511869013611;1194.3610168559778;12476.313802740846;12521.74956500865;12527.686807829787;12536.561220357244;12540.81188782169;4457.665675074318;4579.977100114478;4634;4657.138429390574;4672.252439609714;10594.947025264979;10597.4701264938;10604.840927386096;10607.045365917105;10615.203859710398;5191.922121168185;5224.268602395668;5240.895182096337;5243.4232234454175;5253.44838791929;4703.553162449562;4770.713757174581;4781.6891902026255;4782.808687652455;4903.485134060944;4004.959950400517;4009.759414435085;4059.167870586523;4115.794210289474;4144.8134833932545;1242.3477674220926;1270.3076823131416;1274.5539061328461;1275.9043071769654;1284.2551320234243;696.8327601375735;881.3125761905724;909.7998440343114;913.7989642278689;915.2769312243387;5440.211169380417;5619.80330688424;5707.885842283131;5708.143778433268;5855.3266374367495;896.3859756067114;897.6050537763364;950.7100334398075;951.8667386565886;954.2699834626517;3841.193349396602;3939.4090886366703;3945.6251656092627;3956.4460975463458;4002.539707933625;10652.733681658021;11190.608328708457;11215.551377944954;11262.986331230228;11325.546978120949;9848.310618256797;10398.68803935883;10980.341179529254;11022;11134.16493762971;7769.300762931363;7979.800504987422;8039.437239393304;8044.557549334842;8115.188481151838;5711.314642242957;5918.17145599625;5952.196453478725;5970.194023806905;5997.250343707036;9867.16129129032;10256.07695307426;10259.281850270409;10278.229132814919;10350.275480716278;10451.68644940653;10584.047435730821;10629.89370106289;10679.839802402816;10727.570897164025;7948.244916732901;7957.8408431832195;8060.83878322442;8128.512289262663;8135.959320203361;8540.615672294885;8617.439866408664;8662.263707584925;8669.653213871374;8690.695825646071;7745.070591529053;7853.72242049822;7930.841383172419;7930.9603451982375;8058.758237252891;7516.774496765106;7520.811979700551;7546.169921308761;7682.654280557276;7690.6539205737;7030.964845175741;7088.964555177191;7100.928990710234;7106.360427561544;7111.751088711871;4932.136876046606;5076.898462030813;5155.613329000415;5212.713300768342;5229.92155117666;5089.898202035864;5113.769880355468;5179.689218646893;5246.449122842199;5248.291480650216 02:43:40 INFO - PROCESS | 18386 | |4;prototype.html;293.2434319455803;304.04075142924074;309.0604562131121;312.91238453233103;314;5235.869103272411;5251.159814429692;5307.920381194285;5308.150695888658;5313.867153321169;5201.90759940412;5207.218917162428;5214.426413094566;5220.799216180271;5243.9213411798755;4106.240345536085;4109.445224894645;4116.382542618616;4120.866761640543;4130.987907962553;4111.403846442264;4116.773577453238;4119.073208528072;4124.484439445069;4150.232207041707;3994.560598334181;4066.1054567994993;4077.7349472284354;4079.4084857695616;4092.202020605983;4028.5568587455355;4033.3949907513816;4039.8788036358956;4057.5536690963972;4081.6122468365456;3596.4605309203566;3600.71194304455;3618.7285953553587;3629.5825980012373;3633.981830090859;5043.84868453947;5111.309973153614;5132.692038477703;5169.147090730025;5194.532492075694;4603.930941035887;4619.422572178478;4651.465081515636;4656.953430465685;4666.440027196758;5457.945420545783;5476.17857321405;5481.808136715196;5505.532029777473;5507.118860982264;3873.845046198149;3920.137569734654;3960.386140148282;3977.76133431995;3979.8408063677416;5405.540529055035;5548.972255138739;5699.147776972501;5703.914441283384;5712.371639119735;3886.7862267574988;3891.610838916086;3904.7852368119457;3913.6086391361205;4018.1160144768105;4043.454133691973;4058.6550143238155;4066.2921572939435;4066.7356621819486;4068.3897415387337;4380.496242932039;4480.439945006874;4599.793009314589;4646.581807637329;4649.5350464953235;5452.664097296109;5454.509094181542;5460.590455715837;5474.698891560923;5478.780848766084;1375.24361601119;1383.5503461375092;1391.193107997359;1391.8538553451742;1400.1529074909736;857.3526987124806;890.7817584691792;893.489295080825;905.9818803624022;910.5811326789751;4693.718376897397;4697.271922851964;4704.764761761967;4707.411573553306;4707.6233901287815;4855.373449894254;4934.753262336869;4960.950390496121;4968.801247950114;5003.4746351633285;4639.190715620911;4660.464046634613;4697.459792123881;4705.341252224691;4939.827106051271;2957.0833041757123;2981.4633365993895;2997.250687328168;3002.384511175204;3012.5631783391723;5734.942650573525;5744.798932037359;5745.6552606843725;5769.365369809318;5779.479846813723;5501.449855014546;5678.6371270895515;5719.714014299351;5725.85482903421;5760.855978600484;5725.456081672234;5743.511801496919;5792.594518383673;5794.971025144931;5797.8550536236935;5502.669839809624;5626.746796394254;5668.801591944262;5701.7149142541875;5716.79991200306;5330.360356757214;5624.325080990144;5628.718564071698;5645.548356131581;5645.604807663424;5632.5212356950115;5741.158126727297;5765.365809760839;5786.363500014911;5789.507891829073;3898.6491215790716;3931.3906344516645;3934.4098385241296;3936.448897154458;3960.821763020613;5364.30264065669;5567.635929197372;5647.6329038614;5648.943510564842;5664.207011018543;5471.6169868108855;5517.944820551743;5529.972350138223;5537.667739935617;5548.528375088163;5515.676237703003;5524.723763811713;5525.502704756431;5536.591582661556;5538.307711536058;5220.295260139985;5456.890862182655;5471.343438787212;5479.287692599936;5508;5530.55755539564;5549.112142057252;5558.777648894161;5561.304836895388;5577.74900129487;5166.922496162485;5429.484199001088;5435.728213589384;5440.727963601883;5479.123340265698 02:43:40 INFO - PROCESS | 18386 | |5;yui.html;733.2008111158837;750.5084169868735;786.8504984053029;795.1094773853285;796.7689370082676;14964.401423943043;15753.684926301496;15824;15833.683326333467;15866.286017129229;14600.41598336068;14737.631559211026;14777.261136943163;14779.704405911902;14823;650.801505540811;781.9022622172229;789.6525528767353;805.6253841963486;809.4738420026971;798.0662624729052;804.7344376355818;806.7378102116807;808.2483290539795;808.8018435483315;673.2930423055797;838.5639467476939;858.3905427146733;859.6733241368303;861.4745005546612;608.9451949324559;623.1307326279837;624.3194917539903;624.9625022498665;626.1734510446213;463.09927191612326;463.4577544273208;463.80520181523843;464.64918986165566;466.1725437348699;13195.472181112744;13370;13382.531611393651;13400.463981440731;13474.326283685874;13899.861001389958;14275.143491390447;14357.425702971868;14452.421903123863;14519.346629401596;13206.339683015907;13249.602511924657;13409.128406653535;13499.392527336293;13536.120152190077;4418.072204836956;4462.933056004163;4473.865784026484;4520.751358675271;4653.302004699289;75328.62335688286;76294.61852690701;76529;77418.61290693567;81043.5947820263;11488;11670.416479176007;11791.88208117925;11870.94064529689;11946.163768536293;21569.460763481038;21706.782932170478;21756.673649895263;21840.563188736138;21856.89071554632;8473.66105355779;8473.83052338962;8653.350998675125;8671.089535598798;8772.78068048291;4564.543545645409;4667.976660116746;4720.268358404453;4744.335792988915;4884.120858245479;3391.8982430527126;3480.5301284326797;3491.877784277538;3495.702865256482;3501.4222653262436;593.9049752039653;598.7395482964924;605.3915814606293;605.8909396308619;618.7710547097603;540.9404965453797;593.9138824870456;603.3693098092314;674.9942585547597;675.4393853101914;9532.285078619132;9592.232621390272;9623.374480658735;9693.273004524688;10068.69793906184;622.8038167977073;632.3423639414957;649.6199723162003;663.3929954091952;692.9376356127973;4406.20688276107;4464.821407143743;4481.731096134177;4610.216263235258;4677.789499472532;63944;65238;95052;119826.40086799511;123116;100138.49930750299;102948;105311;105653.47173264239;107999.38000929993;88899;91071;91151.54424227837;92913.0708692918;94095.52952235332;8292.2951549119;8444.863148555212;8452.788680283042;8482.533460659723;8505.872411913702;53415.73292133515;53901.73049134886;54277;54741.178882316;55745.721271393384;67028;76253.61873190598;76455.61772191104;76558;77344.61327693326;11420.988036200693;11631.418429078343;11689;11770.588029419272;12089.818652720392;12535.185212961129;12711.36443177819;12998.480060797463;13059.934700326437;13364.732705345645;12118.575849845212;12235.69410764738;12357.196782209128;12458.813117803058;12633.3683315832;11692.532298707956;12065.396730163633;12229.816552751538;12329.815052774395;12752.553660621834;11373.20387572895;11859.288442693465;11924.105692072955;12065.758684826429;12132.090093243218;9404.623815047322;9511.85745161892;9629;9649.228061755182;9700.90299097;9527;9909.207263419054;9917.851232231667;10015.949920250352;10027.899721002697 02:43:40 INFO - PROCESS | 18386 | __end_tp_report 02:43:40 INFO - PROCESS | 18386 | __start_cc_report 02:43:40 INFO - PROCESS | 18386 | _x_x_mozilla_cycle_collect,916 02:43:40 INFO - PROCESS | 18386 | __end_cc_report 02:43:40 INFO - PROCESS | 18386 | __startTimestamp1467884620367__endTimestamp 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | ------- Summary: start ------- 02:43:40 INFO - PROCESS | 18386 | Number of tests: 6 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#0] dojo.html Cycles:165 Average:5366.05 Median:5571.00 stddev:618.08 (11.1%) stddev-sans-first:593.53 02:43:40 INFO - PROCESS | 18386 | Values: 3086.1 3086.6 3095.1 3120.0 3125.8 5221.2 5313.8 5318.2 5433.1 5453.5 5382.5 5400.6 5410.8 5418.4 5424.9 4845.8 4894.6 4923.2 4944.5 5051.7 4944.2 4944.3 4993.9 5000.2 5014.8 4731.5 4779.5 4850.2 4861.8 4867.9 4785.9 4829.3 4885.7 4895.3 4943.2 4743.5 4851.3 4852.9 4900.0 4926.3 5305.6 5391.1 5407.5 5473.2 5478.2 5835.8 5856.9 5860.6 5874.4 5876.2 5565.5 5640.5 5746.4 5918.7 5928.0 5522.9 5550.1 5551.7 5557.5 5574.7 6029.6 6031.5 6041.9 6043.2 6044.1 5501.8 5633.5 5684.8 5704.3 5812.9 5852.0 5857.6 5864.9 5882.8 5885.5 5699.0 5702.7 5715.4 5720.6 5721.3 5520.6 5686.6 5699.3 5746.1 5802.0 4402.0 4415.8 4416.6 4417.6 4455.9 3882.9 3943.6 3951.1 3968.0 3975.6 5288.5 5402.6 5436.2 5466.6 5494.0 5853.4 5866.2 5868.5 5871.4 5911.6 5290.3 5510.3 5512.6 5514.8 5520.1 4893.5 4957.0 4961.8 4994.6 5012.1 5901.9 5906.5 5910.9 5912.6 5923.4 5608.5 5717.0 5784.5 5803.6 5806.2 5901.5 5951.5 5956.0 5963.6 5975.3 5696.6 5705.1 5706.6 5712.0 5713.5 5570.9 5695.6 5734.7 5762.3 5788.0 5643.5 5649.1 5653.6 5656.7 5701.7 5579.1 5628.7 5637.7 5641.0 5648.5 5432.4 5534.8 5544.5 5569.2 5590.8 5669.6 5675.6 5680.9 5731.8 5736.6 5571.0 5573.4 5573.7 5574.9 5582.7 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#1] ext.html Cycles:180 Average:62001.47 Median:44932.44 stddev:124365.67 (276.8%) stddev-sans-first:124629.07 02:43:40 INFO - PROCESS | 18386 | Values: 586.7 608.2 617.2 641.6 645.0 43779.5 44925.3 44939.6 44958.6 49164.8 46489.0 47169.0 47177.3 47181.5 47315.3 9025.7 9156.7 9157.7 9170.9 9178.2 9043.4 9132.5 9140.0 9147.8 9152.0 9166.2 9193.9 9209.7 9213.4 9216.9 9070.3 9133.2 9137.6 9138.9 9153.5 8907.2 9064.7 9066.2 9069.5 9075.8 44312.8 44920.8 44943.0 44944.3 44944.6 3570.8 3697.8 3705.9 3736.6 4014.9 33462.8 34121.1 34315.3 35829.5 35924.5 3851.1 3877.5 3932.6 3934.1 4154.0 252785.0 253883.0 254022.0 254071.0 254145.0 52800.2 61173.7 61988.7 62052.7 62108.7 53451.7 54571.5 54599.7 54637.0 54772.0 17340.7 17445.3 17492.0 17496.2 17503.0 12352.0 12547.9 13460.3 13535.0 13565.7 16880.4 18123.3 18197.6 18245.5 19290.8 6496.0 6632.6 6645.7 6886.9 6941.8 903.1 942.2 1002.3 1008.3 1022.4 32754.3 34392.5 34507.5 34592.3 34801.7 1123.3 1130.2 1134.7 1142.4 1163.2 17324.4 17815.2 17840.0 17881.9 17908.5 615770.0 621478.0 622213.0 623532.0 627978.0 61809.4 61829.0 61961.0 62473.4 62506.0 1233.0 1312.1 1323.0 1383.9 1399.7 33216.0 34583.1 34942.3 35023.5 35034.3 51532.7 52127.0 52482.7 52587.7 52674.0 447706.0 448410.0 449967.0 450153.0 453038.0 38369.6 44481.3 44692.1 45103.1 48625.3 50176.5 50708.5 51107.7 51255.7 51737.2 41917.4 41919.0 42144.4 43150.6 43895.0 42279.0 42471.6 42520.0 42894.4 43654.0 42884.4 42918.1 44708.3 46635.3 46828.3 40786.0 45735.8 45897.3 47050.8 47477.5 34021.0 34922.0 35360.6 35455.6 35757.3 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#2] jquery.html Cycles:180 Average:24663.68 Median:193908.60 stddev:56425.58 (29.1%) stddev-sans-first:56554.38 02:43:40 INFO - PROCESS | 18386 | Values: 367.8 390.2 392.3 392.8 415.6 14390.1 16560.5 19294.5 19437.4 19442.5 18065.3 18587.2 18800.6 18811.2 18853.9 4211.6 5681.3 5772.8 5802.9 5803.3 6176.5 6518.1 6534.2 6604.1 6613.7 6279.8 6473.8 6487.4 6540.4 6580.8 6242.0 6409.8 6438.9 6439.1 6468.2 5787.5 5809.2 5815.4 5818.2 5826.6 23073.2 23278.2 23316.7 23744.4 23806.5 2153.4 2223.8 2253.1 2337.6 2597.7 9346.0 9465.0 9539.8 9696.2 10032.7 1895.8 1966.9 1976.8 1993.1 2023.2 82847.0 83289.0 83811.6 89199.6 89227.0 9365.0 9977.0 10930.4 10974.6 11092.7 15069.8 15188.7 15209.2 15215.1 15234.5 8286.3 8407.2 8453.6 8621.2 8635.0 8306.4 8324.9 8365.7 8468.4 8523.3 4446.0 4499.1 4529.3 4617.2 4753.8 1927.7 1963.9 1974.5 1999.4 2022.5 875.5 959.4 988.7 1041.8 1099.7 18810.5 19699.5 19743.1 19782.4 19788.7 968.8 999.0 1010.6 1011.2 1016.2 10320.3 10671.5 10981.1 10987.8 10989.5 315618.0 320427.0 323214.0 324115.0 387427.0 71786.3 72221.6 82692.2 91786.5 96415.0 952.3 973.9 1003.1 1003.5 1007.7 17305.1 17420.3 17678.2 17707.6 17727.0 42789.8 44049.8 44264.0 44591.8 45837.8 57826.4 58557.4 59302.4 59380.0 60663.7 7547.6 7614.8 7622.5 8052.2 8244.9 9386.6 12864.4 13479.9 13736.0 14151.4 12102.1 12267.3 12289.2 12316.8 12428.7 11812.1 12039.5 12086.9 12110.2 12177.7 12090.8 12236.7 12505.2 12534.6 12802.6 7958.5 7993.7 8114.4 8172.6 8260.5 9760.6 11696.9 11851.6 11874.6 11975.2 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#3] mootools.html Cycles:180 Average:5817.96 Median:4782.25 stddev:3358.40 (70.2%) stddev-sans-first:3351.73 02:43:40 INFO - PROCESS | 18386 | Values: 1443.4 1489.5 1579.3 1708.3 1723.3 8489.6 9015.2 9078.2 9084.5 9104.6 7453.6 8376.7 8617.7 8629.2 8835.4 2311.7 2339.7 2341.4 2341.7 2341.9 2308.7 2325.0 2326.4 2328.9 2333.0 2016.0 2083.5 2087.6 2090.2 2209.5 2266.9 2303.5 2304.2 2309.3 2314.3 2283.6 2284.6 2324.1 2325.0 2325.8 8889.0 8921.4 8931.9 8935.6 8951.8 4984.0 5122.4 5136.7 5154.4 5167.3 3323.3 3393.0 3401.5 3401.7 3410.5 1132.3 1154.9 1172.8 1187.2 1194.4 12476.3 12521.7 12527.7 12536.6 12540.8 4457.7 4580.0 4634.0 4657.1 4672.3 10594.9 10597.5 10604.8 10607.0 10615.2 5191.9 5224.3 5240.9 5243.4 5253.4 4703.6 4770.7 4781.7 4782.8 4903.5 4005.0 4009.8 4059.2 4115.8 4144.8 1242.3 1270.3 1274.6 1275.9 1284.3 696.8 881.3 909.8 913.8 915.3 5440.2 5619.8 5707.9 5708.1 5855.3 896.4 897.6 950.7 951.9 954.3 3841.2 3939.4 3945.6 3956.4 4002.5 10652.7 11190.6 11215.6 11263.0 11325.5 9848.3 10398.7 10980.3 11022.0 11134.2 7769.3 7979.8 8039.4 8044.6 8115.2 5711.3 5918.2 5952.2 5970.2 5997.3 9867.2 10256.1 10259.3 10278.2 10350.3 10451.7 10584.0 10629.9 10679.8 10727.6 7948.2 7957.8 8060.8 8128.5 8136.0 8540.6 8617.4 8662.3 8669.7 8690.7 7745.1 7853.7 7930.8 7931.0 8058.8 7516.8 7520.8 7546.2 7682.7 7690.7 7031.0 7089.0 7100.9 7106.4 7111.8 4932.1 5076.9 5155.6 5212.7 5229.9 5089.9 5113.8 5179.7 5246.4 5248.3 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#4] prototype.html Cycles:180 Average:4564.70 Median:5198.22 stddev:1344.95 (25.9%) stddev-sans-first:1309.95 02:43:40 INFO - PROCESS | 18386 | Values: 293.2 304.0 309.1 312.9 314.0 5235.9 5251.2 5307.9 5308.2 5313.9 5201.9 5207.2 5214.4 5220.8 5243.9 4106.2 4109.4 4116.4 4120.9 4131.0 4111.4 4116.8 4119.1 4124.5 4150.2 3994.6 4066.1 4077.7 4079.4 4092.2 4028.6 4033.4 4039.9 4057.6 4081.6 3596.5 3600.7 3618.7 3629.6 3634.0 5043.8 5111.3 5132.7 5169.1 5194.5 4603.9 4619.4 4651.5 4657.0 4666.4 5457.9 5476.2 5481.8 5505.5 5507.1 3873.8 3920.1 3960.4 3977.8 3979.8 5405.5 5549.0 5699.1 5703.9 5712.4 3886.8 3891.6 3904.8 3913.6 4018.1 4043.5 4058.7 4066.3 4066.7 4068.4 4380.5 4480.4 4599.8 4646.6 4649.5 5452.7 5454.5 5460.6 5474.7 5478.8 1375.2 1383.6 1391.2 1391.9 1400.2 857.4 890.8 893.5 906.0 910.6 4693.7 4697.3 4704.8 4707.4 4707.6 4855.4 4934.8 4961.0 4968.8 5003.5 4639.2 4660.5 4697.5 4705.3 4939.8 2957.1 2981.5 2997.3 3002.4 3012.6 5734.9 5744.8 5745.7 5769.4 5779.5 5501.4 5678.6 5719.7 5725.9 5760.9 5725.5 5743.5 5792.6 5795.0 5797.9 5502.7 5626.7 5668.8 5701.7 5716.8 5330.4 5624.3 5628.7 5645.5 5645.6 5632.5 5741.2 5765.4 5786.4 5789.5 3898.6 3931.4 3934.4 3936.4 3960.8 5364.3 5567.6 5647.6 5648.9 5664.2 5471.6 5517.9 5530.0 5537.7 5548.5 5515.7 5524.7 5525.5 5536.6 5538.3 5220.3 5456.9 5471.3 5479.3 5508.0 5530.6 5549.1 5558.8 5561.3 5577.7 5166.9 5429.5 5435.7 5440.7 5479.1 02:43:40 INFO - PROCESS | 18386 | 02:43:40 INFO - PROCESS | 18386 | [#5] yui.html Cycles:180 Average:20320.20 Median:4672.88 stddev:29548.27 (632.3%) stddev-sans-first:29594.56 02:43:40 INFO - PROCESS | 18386 | Values: 733.2 750.5 786.9 795.1 796.8 14964.4 15753.7 15824.0 15833.7 15866.3 14600.4 14737.6 14777.3 14779.7 14823.0 650.8 781.9 789.7 805.6 809.5 798.1 804.7 806.7 808.2 808.8 673.3 838.6 858.4 859.7 861.5 608.9 623.1 624.3 625.0 626.2 463.1 463.5 463.8 464.6 466.2 13195.5 13370.0 13382.5 13400.5 13474.3 13899.9 14275.1 14357.4 14452.4 14519.3 13206.3 13249.6 13409.1 13499.4 13536.1 4418.1 4462.9 4473.9 4520.8 4653.3 75328.6 76294.6 76529.0 77418.6 81043.6 11488.0 11670.4 11791.9 11870.9 11946.2 21569.5 21706.8 21756.7 21840.6 21856.9 8473.7 8473.8 8653.4 8671.1 8772.8 4564.5 4668.0 4720.3 4744.3 4884.1 3391.9 3480.5 3491.9 3495.7 3501.4 593.9 598.7 605.4 605.9 618.8 540.9 593.9 603.4 675.0 675.4 9532.3 9592.2 9623.4 9693.3 10068.7 622.8 632.3 649.6 663.4 692.9 4406.2 4464.8 4481.7 4610.2 4677.8 63944.0 65238.0 95052.0 119826.4 123116.0 100138.5 102948.0 105311.0 105653.5 107999.4 88899.0 91071.0 91151.5 92913.1 94095.5 8292.3 8444.9 8452.8 8482.5 8505.9 53415.7 53901.7 54277.0 54741.2 55745.7 67028.0 76253.6 76455.6 76558.0 77344.6 11421.0 11631.4 11689.0 11770.6 12089.8 12535.2 12711.4 12998.5 13059.9 13364.7 12118.6 12235.7 12357.2 12458.8 12633.4 11692.5 12065.4 12229.8 12329.8 12752.6 11373.2 11859.3 11924.1 12065.8 12132.1 9404.6 9511.9 9629.0 9649.2 9700.9 9527.0 9909.2 9917.9 10015.9 10027.9 02:43:40 INFO - PROCESS | 18386 | -------- Summary: end -------- 02:43:40 INFO - PROCESS | 18386 | 02:43:41 INFO - TEST-INFO | 18386: exit 0 02:43:41 INFO - TEST-OK | dromaeo_css | took 1113579ms 02:43:41 INFO - TEST-START | kraken 02:43:41 INFO - operating with platform_type : linux_ 02:43:41 INFO - Initialising browser for kraken test... 02:43:41 INFO - TEST-INFO | started process 18588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5xDjwy/profile http://localhost:48864/getInfo.html) 02:43:44 INFO - PROCESS | 18588 | __metrics Screen width/height:1600/1200 02:43:44 INFO - PROCESS | 18588 | colorDepth:24 02:43:44 INFO - PROCESS | 18588 | Browser inner width/height: 1024/697 02:43:44 INFO - PROCESS | 18588 | __metrics 02:43:45 INFO - PROCESS | 18588 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:46 INFO - TEST-INFO | 18588: exit 0 02:43:46 INFO - Browser initialized. 02:43:46 INFO - Running cycle 1/1 for kraken test... 02:43:46 INFO - TEST-INFO | started process 18677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5xDjwy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:58 INFO - PROCESS | 18677 | RSS: Main: 157351936 02:43:58 INFO - PROCESS | 18677 | 02:44:00 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48864/tests/kraken/driver.html?testName=audio-beat-detection) 02:44:01 INFO - PROCESS | 18677 | RSS: Main: 215728128 02:44:01 INFO - PROCESS | 18677 | 02:44:04 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48864/tests/kraken/driver.html?testName=audio-dft) 02:44:04 INFO - PROCESS | 18677 | RSS: Main: 204038144 02:44:04 INFO - PROCESS | 18677 | 02:44:07 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48864/tests/kraken/driver.html?testName=audio-fft) 02:44:08 INFO - PROCESS | 18677 | RSS: Main: 269299712 02:44:08 INFO - PROCESS | 18677 | 02:44:10 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48864/tests/kraken/driver.html?testName=audio-oscillator) 02:44:11 INFO - PROCESS | 18677 | RSS: Main: 180465664 02:44:11 INFO - PROCESS | 18677 | 02:44:13 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:13 INFO - PROCESS | 18677 | RSS: Main: 184229888 02:44:13 INFO - PROCESS | 18677 | 02:44:16 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48864/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:17 INFO - PROCESS | 18677 | RSS: Main: 219107328 02:44:17 INFO - PROCESS | 18677 | 02:44:20 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48864/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:21 INFO - PROCESS | 18677 | RSS: Main: 221065216 02:44:21 INFO - PROCESS | 18677 | 02:44:24 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48864/tests/kraken/driver.html?testName=json-parse-financial) 02:44:25 INFO - PROCESS | 18677 | RSS: Main: 221380608 02:44:25 INFO - PROCESS | 18677 | 02:44:26 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:27 INFO - PROCESS | 18677 | RSS: Main: 206602240 02:44:27 INFO - PROCESS | 18677 | 02:44:28 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:29 INFO - PROCESS | 18677 | RSS: Main: 209756160 02:44:29 INFO - PROCESS | 18677 | 02:44:31 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:32 INFO - PROCESS | 18677 | RSS: Main: 208166912 02:44:32 INFO - PROCESS | 18677 | 02:44:34 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:35 INFO - PROCESS | 18677 | RSS: Main: 221102080 02:44:35 INFO - PROCESS | 18677 | 02:44:38 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:38 INFO - PROCESS | 18677 | RSS: Main: 222302208 02:44:38 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:48864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48864/tests/kraken/driver.html?testName=ai-astar) 02:44:40 INFO - PROCESS | 18677 | RSS: Main: 264249344 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | __start_tp_report 02:44:40 INFO - PROCESS | 18677 | _x_x_mozilla_page_load 02:44:40 INFO - PROCESS | 18677 | _x_x_mozilla_page_load_details 02:44:40 INFO - PROCESS | 18677 | |i|pagename|runs| 02:44:40 INFO - PROCESS | 18677 | |0;ai-astar;100;109;111;110;111;110;109;111;110;110 02:44:40 INFO - PROCESS | 18677 | |1;audio-beat-detection;146;123;119;183;124;118;141;116;145;118 02:44:40 INFO - PROCESS | 18677 | |2;audio-dft;162;162;162;159;162;162;162;162;161;162 02:44:40 INFO - PROCESS | 18677 | |3;audio-fft;77;75;76;107;76;77;77;75;111;74 02:44:40 INFO - PROCESS | 18677 | |4;audio-oscillator;83;86;114;84;85;84;122;85;86;125 02:44:40 INFO - PROCESS | 18677 | |5;imaging-gaussian-blur;118;118;117;116;118;117;116;117;117;118 02:44:40 INFO - PROCESS | 18677 | |6;imaging-darkroom;147;148;146;146;146;147;146;146;147;147 02:44:40 INFO - PROCESS | 18677 | |7;imaging-desaturate;95;96;96;96;97;96;97;96;95;95 02:44:40 INFO - PROCESS | 18677 | |8;json-parse-financial;54;54;56;55;54;66;54;53;52;54 02:44:40 INFO - PROCESS | 18677 | |9;json-stringify-tinderbox;64;65;63;64;63;65;64;64;64;63 02:44:40 INFO - PROCESS | 18677 | |10;stanford-crypto-aes;77;75;82;77;76;76;75;75;81;80 02:44:40 INFO - PROCESS | 18677 | |11;stanford-crypto-ccm;124;121;117;120;122;125;119;119;163;125 02:44:40 INFO - PROCESS | 18677 | |12;stanford-crypto-pbkdf2;158;160;157;156;154;159;162;157;165;159 02:44:40 INFO - PROCESS | 18677 | |13;stanford-crypto-sha256-iterative;66;63;62;63;63;63;65;64;67;61 02:44:40 INFO - PROCESS | 18677 | __end_tp_report 02:44:40 INFO - PROCESS | 18677 | __start_cc_report 02:44:40 INFO - PROCESS | 18677 | _x_x_mozilla_cycle_collect,1644 02:44:40 INFO - PROCESS | 18677 | __end_cc_report 02:44:40 INFO - PROCESS | 18677 | __startTimestamp1467884680521__endTimestamp 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | ------- Summary: start ------- 02:44:40 INFO - PROCESS | 18677 | Number of tests: 14 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.28 (3.0%) stddev-sans-first:0.78 02:44:40 INFO - PROCESS | 18677 | Values: 100.0 109.0 111.0 110.0 111.0 110.0 109.0 111.0 110.0 110.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:132.50 stddev:21.06 (15.9%) stddev-sans-first:21.83 02:44:40 INFO - PROCESS | 18677 | Values: 146.0 123.0 119.0 183.0 124.0 118.0 141.0 116.0 145.0 118.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:44:40 INFO - PROCESS | 18677 | Values: 162.0 162.0 162.0 159.0 162.0 162.0 162.0 162.0 161.0 162.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.03 (18.5%) stddev-sans-first:14.74 02:44:40 INFO - PROCESS | 18677 | Values: 77.0 75.0 76.0 107.0 76.0 77.0 77.0 75.0 111.0 74.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.50 stddev:17.44 (20.6%) stddev-sans-first:17.91 02:44:40 INFO - PROCESS | 18677 | Values: 83.0 86.0 114.0 84.0 85.0 84.0 122.0 85.0 86.0 125.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 02:44:40 INFO - PROCESS | 18677 | Values: 118.0 118.0 117.0 116.0 118.0 117.0 116.0 117.0 117.0 118.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:44:40 INFO - PROCESS | 18677 | Values: 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 02:44:40 INFO - PROCESS | 18677 | Values: 95.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 95.0 95.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:3.94 (7.3%) stddev-sans-first:4.15 02:44:40 INFO - PROCESS | 18677 | Values: 54.0 54.0 56.0 55.0 54.0 66.0 54.0 53.0 52.0 54.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 02:44:40 INFO - PROCESS | 18677 | Values: 64.0 65.0 63.0 64.0 63.0 65.0 64.0 64.0 64.0 63.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:2.63 (3.4%) stddev-sans-first:2.79 02:44:40 INFO - PROCESS | 18677 | Values: 77.0 75.0 82.0 77.0 76.0 76.0 75.0 75.0 81.0 80.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:123.00 stddev:13.45 (10.9%) stddev-sans-first:14.26 02:44:40 INFO - PROCESS | 18677 | Values: 124.0 121.0 117.0 120.0 122.0 125.0 119.0 119.0 163.0 125.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:3.13 (2.0%) stddev-sans-first:3.31 02:44:40 INFO - PROCESS | 18677 | Values: 158.0 160.0 157.0 156.0 154.0 159.0 162.0 157.0 165.0 159.0 02:44:40 INFO - PROCESS | 18677 | 02:44:40 INFO - PROCESS | 18677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.83 (2.9%) stddev-sans-first:1.74 02:44:40 INFO - PROCESS | 18677 | Values: 66.0 63.0 62.0 63.0 63.0 63.0 65.0 64.0 67.0 61.0 02:44:40 INFO - PROCESS | 18677 | -------- Summary: end -------- 02:44:40 INFO - PROCESS | 18677 | 02:44:41 INFO - TEST-INFO | 18677: exit 0 02:44:41 INFO - TEST-OK | kraken | took 60409ms 02:44:41 INFO - SUITE-END | took 1173s 02:44:41 INFO - Completed test suite (00:19:34) 02:44:41 INFO - javascript benchmark 02:44:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.089603566948, 3086.6141732283463, 3095.117891400951, 3120.032789835151, 3125.8280794556304, 5221.164613661815, 5313.814016509423, 5318.202269659549, 5433.130699088147, 5453.509184173424, 5382.4886635769635, 5400.621956463049, 5410.810621628244, 5418.4039755626945, 5424.891502169954, 4845.830395936134, 4894.583960363373, 4923.187674033798, 4944.53026962438, 5051.696898186102, 4944.233643785219, 4944.283078953567, 4993.901341704837, 5000.174971129777, 5014.84955451337, 4731.5268473152755, 4779.498152693969, 4850.151223535902, 4861.805527778884, 4867.853964381075, 4785.880352991168, 4829.3480380148585, 4885.7068575885205, 4895.290182923492, 4943.233798761198, 4743.478217396084, 4851.345068415754, 4852.927206091911, 4899.951000489985, 4926.285688575136, 5305.602079843989, 5391.137418013099, 5407.540359069484, 5473.233747275384, 5478.233047373371, 5835.766569337221, 5856.941430585724, 5860.560457965669, 5874.441928016831, 5876.2067120938555, 5565.499105080562, 5640.464155905182, 5746.36789953109, 5918.704064796743, 5928.0, 5522.91715624266, 5550.084236101038, 5551.694656793915, 5557.499825015768, 5574.693391863446, 6029.638221706711, 6031.5476339273855, 6041.852048110845, 6043.244594425697, 6044.063170208625, 5501.752421141058, 5633.492985631313, 5684.772609095672, 5704.315482142087, 5812.912806307909, 5852.005159122959, 5857.648541087548, 5864.941350586525, 5882.794102206402, 5885.47030767233, 5699.031164702011, 5702.714864256771, 5715.428457154251, 5720.628159169641, 5721.256236689287, 5520.613557050968, 5686.60193786431, 5699.316082070178, 5746.13807928814, 5801.970990145022, 4401.955980440219, 4415.757133357632, 4416.580424859633, 4417.558244175557, 4455.866324010285, 3882.883513494543, 3943.645071943539, 3951.1110000249714, 3968.0278331808313, 3975.6223158799867, 5288.471152884757, 5402.648827826179, 5436.238926550286, 5466.562674985991, 5494.011078005998, 5853.385394533512, 5866.208061911588, 5868.471837534557, 5871.4128587141795, 5911.556633252438, 5290.338707661543, 5510.256115424447, 5512.5589952803675, 5514.80698175562, 5520.089185284383, 4893.535114164149, 4957.03337849116, 4961.82633607822, 4994.575461085776, 5012.147934851084, 5901.881962360814, 5906.527477801766, 5910.940890591039, 5912.556558258148, 5923.437273459014, 5608.495235428831, 5717.028105222039, 5784.4504772046585, 5803.636145505719, 5806.2451881255165, 5901.527877769854, 5951.464368206709, 5955.970220148872, 5963.642181469126, 5975.312839023568, 5696.572757043155, 5705.144228365778, 5706.600537962303, 5712.0, 5713.542916566582, 5570.944290557042, 5695.629784064023, 5734.741936612946, 5762.337331206965, 5788.044972579645, 5643.492085712305, 5649.067903795828, 5653.632513886584, 5656.717164141694, 5701.6864072474755, 5579.12021947389, 5628.718564071862, 5637.661740295595, 5641.0, 5648.4633959773755, 5432.429594892479, 5534.7509362078, 5544.473275038865, 5569.164625306236, 5590.776368945197, 5669.6314739541795, 5675.631083979528, 5680.943190568041, 5731.828045158652, 5736.627119237236, 5570.997220500349, 5573.442655734556, 5573.721313934206, 5574.9442505574425, 5582.748776304995], "value": 5323.735325680633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6626689653448, 608.2214765100671, 617.1853153836935, 641.5605310362403, 645.0356716708521, 43779.467718629814, 44925.32612010823, 44939.55060449395, 44958.55041449588, 49164.75417622916, 46489.0, 47169.0, 47177.29234061483, 47181.52818471814, 47315.290270645964, 9025.684101056464, 9156.679516216935, 9157.679481218158, 9170.862437063415, 9178.173964343208, 9043.412178208395, 9132.452052876815, 9139.95430022849, 9147.771305717344, 9152.039035901234, 9166.220871225954, 9193.862092068624, 9209.677661281856, 9213.355065145442, 9216.861747073799, 9070.27437804974, 9133.17801397874, 9137.634494620208, 9138.85764279465, 9153.496557689292, 8907.242884354837, 9064.728058158265, 9066.229370503515, 9069.501177435239, 9075.81848363029, 44312.77843610761, 44920.775396123136, 44943.0, 44944.28085051088, 44944.550554494366, 3570.7500474966764, 3697.815109244527, 3705.907352316187, 3736.5889752127246, 4014.879553613396, 33462.832685836416, 34121.146971325914, 34315.31369372624, 35829.46255806165, 35924.46113308302, 3851.114243723931, 3877.4571559981623, 3932.58707835676, 3934.1344904121047, 4154.044569748944, 252785.0, 253883.0, 254022.0, 254071.0, 254145.0, 52800.207996880075, 61173.69413152906, 61988.69005654943, 62052.68973655103, 62108.68945655243, 53451.73274133605, 54571.45428545743, 54599.727001364736, 54637.0, 54772.0, 17340.65318693619, 17445.30218791234, 17492.0, 17496.21267042986, 17503.0, 12352.0, 12547.874521254671, 13460.326983650779, 13535.0, 13565.660858478617, 16880.396362345557, 18123.275068997093, 18197.636047279244, 18245.452636420927, 19290.807091929182, 6496.0, 6632.6352050636715, 6645.667716614246, 6886.931130688629, 6941.826454338581, 903.074348792493, 942.1803031362622, 1002.3484734922213, 1008.3496144986443, 1022.3916769522123, 32754.344913101606, 34392.46734433907, 34507.482387764205, 34592.308153836784, 34801.65198348035, 1123.2754873106965, 1130.191912782348, 1134.744682446443, 1142.3888219802366, 1163.168334640736, 17324.39364622232, 17815.198316075806, 17840.0, 17881.910590447224, 17908.46274611764, 615770.0, 621478.0, 622213.0, 623532.0, 627978.0, 61809.381906180366, 61829.0, 61961.0, 62473.37526624766, 62506.0, 1232.993835030837, 1312.1077667186405, 1322.9933850330688, 1383.889288856889, 1399.6500874781304, 33216.0, 34583.13542161466, 34942.301153977285, 35023.47464787979, 35034.299314013064, 51532.74233628808, 52127.0, 52482.73758631335, 52587.73706131445, 52674.0, 447706.0, 448410.0, 449967.0, 450153.0, 453038.0, 38369.61630383772, 44481.33278000768, 44692.10615787731, 45103.09793804171, 48625.270620940006, 50176.498235017185, 50708.492915070376, 51107.744461277456, 51255.74372128116, 51737.223941641656, 41917.37123943205, 41919.0, 42144.36783448312, 43150.568494315914, 43895.0, 42279.0, 42471.575284248, 42520.0, 42894.35658465063, 43654.0, 42884.35673464963, 42918.141637167704, 44708.32937505875, 46635.30047049229, 46828.29757553571, 40786.0, 45735.771321143184, 45897.31154032626, 47050.76474617605, 47477.52522474731, 34021.0, 34922.0, 35360.64639353574, 35455.64544354523, 35757.28485430329], "value": 20959.95311277369, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.78668372344043, 390.19619583657686, 392.3134514599451, 392.82322954670406, 415.63424186715685, 14390.064645798016, 16560.503184904457, 19294.517637059045, 19437.4168774937, 19442.51393715158, 18065.277388904462, 18587.163577639007, 18800.62398752024, 18811.153498092586, 18853.905730471364, 4211.557786432427, 5681.318241810978, 5772.797952071678, 5802.883942321172, 5803.303603567578, 6176.4749996250375, 6518.054882042101, 6534.24856141545, 6604.075429439858, 6613.735450581995, 6279.780207692732, 6473.773417930373, 6487.351264873499, 6540.37866402691, 6580.769673061443, 6242.0, 6409.839754006164, 6438.871222575545, 6439.066335381391, 6468.223813142429, 5787.50806181475, 5809.157672137559, 5815.418458154193, 5818.185454036438, 5826.592138550303, 23073.19243826458, 23278.185263515865, 23316.65025024626, 23744.40638984039, 23806.523869522513, 2153.353993801853, 2223.7998580127705, 2253.1100215414817, 2337.567550003255, 2597.7012643546045, 9345.953270233606, 9464.95267523658, 9539.809203815954, 9696.17582505488, 10032.749181270454, 1895.75355203824, 1966.8721533100445, 1976.762788465379, 1993.1130646862152, 2023.1603884387962, 82847.0, 83289.0, 83811.5809420955, 89199.55400222958, 89227.0, 9364.95317523408, 9977.0, 10930.398828064534, 10974.561017559368, 11092.667219983414, 15069.849301506845, 15188.696226075417, 15209.163496007604, 15215.087094774128, 15234.466793662168, 8286.337093032544, 8407.2433480987, 8453.577321133918, 8621.224089831945, 8635.0, 8306.418550701514, 8324.916750832414, 8365.665373384996, 8468.44955077918, 8523.275521580612, 4445.955540444619, 4499.100179963955, 4529.343245229489, 4617.168909596305, 4753.762311884392, 1927.6530224559715, 1963.9312624058375, 1974.4854159595943, 1999.3602047345, 2022.5247066939257, 875.4747151708924, 959.4291396619001, 988.728099772554, 1041.7916416716687, 1099.6975831646362, 18810.52973675669, 19699.507512312306, 19743.111559979836, 19782.40652780419, 19788.70316945247, 968.8498282766183, 998.9750256243652, 1010.5654568535454, 1011.1708399112804, 1016.202281209262, 10320.329178603366, 10671.519781609846, 10981.12151027916, 10987.780244395068, 10989.505472253768, 315618.0, 320427.0, 323214.0, 324115.0, 387427.0, 71786.282137179, 72221.63889180521, 82692.17307826965, 91786.54106729424, 96415.0, 952.2667545989549, 973.8928717841031, 1003.1072345612411, 1003.4781913405135, 1007.6674697349857, 17305.13474326304, 17420.30318787234, 17678.204480798137, 17707.645847083244, 17727.0, 42789.78605106955, 44049.779751102324, 44264.0, 44591.77704111459, 45837.77081114573, 57826.4217357821, 58557.4144258552, 59302.40697592969, 59380.0, 60663.69668151631, 7547.5848828314965, 7614.771556853303, 7622.466427350254, 8052.194780521901, 8244.876326854983, 9386.577604007973, 12864.421101050288, 13479.865201348253, 13736.0, 14151.363188656329, 12102.092343074128, 12267.325297108744, 12289.201201921847, 12316.753664926471, 12428.689282768004, 11812.114091443347, 12039.518419263131, 12086.939565302117, 12110.212836165621, 12177.695557610776, 12090.75818483643, 12236.694082648006, 12505.187162834387, 12534.615653773613, 12802.551910683082, 7958.482698624571, 7993.72021979228, 8114.43198976066, 8172.5913704315735, 8260.545669988209, 9760.56077476501, 11696.88303116958, 11851.644450666494, 11874.643760687193, 11975.221610595632], "value": 9174.669704322045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.364919435448, 1489.5233525271915, 1579.2893198060876, 1708.2569082449143, 1723.2503860820543, 8489.575521223946, 9015.233705135071, 9078.2283505902, 9084.50035248061, 9104.590293436802, 7453.590052547108, 8376.748697539084, 8617.741467755977, 8629.223369896708, 8835.425697329685, 2311.6648086027517, 2339.6607491913664, 2341.3678306857137, 2341.695579574661, 2341.906323747048, 2308.746037935826, 2324.976750232501, 2326.3718795925092, 2328.860268383902, 2333.0434521846046, 2015.9899200503976, 2083.541620843412, 2087.634663933813, 2090.1848279171136, 2209.4807720185745, 2266.9319920402413, 2303.4702018535663, 2304.2396009316885, 2309.2956648222284, 2314.25943698015, 2283.5775381554467, 2284.565932472825, 2324.070371851256, 2324.97675023251, 2325.8255630827757, 8889.0, 8921.420107692978, 8931.86602200961, 8935.64257429702, 8951.820963580692, 4983.975080124576, 5122.3853137623355, 5136.74316284188, 5154.433012368637, 5167.250748641463, 3323.2854936188837, 3392.9660703392897, 3401.48977653354, 3401.710854577364, 3410.488426735985, 1132.2753437799815, 1154.8614166300015, 1172.7595842852195, 1187.1511869013611, 1194.3610168559778, 12476.313802740846, 12521.74956500865, 12527.686807829787, 12536.561220357244, 12540.81188782169, 4457.665675074318, 4579.977100114478, 4634.0, 4657.138429390574, 4672.252439609714, 10594.947025264979, 10597.4701264938, 10604.840927386096, 10607.045365917105, 10615.203859710398, 5191.922121168185, 5224.268602395668, 5240.895182096337, 5243.4232234454175, 5253.44838791929, 4703.553162449562, 4770.713757174581, 4781.6891902026255, 4782.808687652455, 4903.485134060944, 4004.959950400517, 4009.759414435085, 4059.167870586523, 4115.794210289474, 4144.8134833932545, 1242.3477674220926, 1270.3076823131416, 1274.5539061328461, 1275.9043071769654, 1284.2551320234243, 696.8327601375735, 881.3125761905724, 909.7998440343114, 913.7989642278689, 915.2769312243387, 5440.211169380417, 5619.80330688424, 5707.885842283131, 5708.143778433268, 5855.3266374367495, 896.3859756067114, 897.6050537763364, 950.7100334398075, 951.8667386565886, 954.2699834626517, 3841.193349396602, 3939.4090886366703, 3945.6251656092627, 3956.4460975463458, 4002.539707933625, 10652.733681658021, 11190.608328708457, 11215.551377944954, 11262.986331230228, 11325.546978120949, 9848.310618256797, 10398.68803935883, 10980.341179529254, 11022.0, 11134.16493762971, 7769.300762931363, 7979.800504987422, 8039.437239393304, 8044.557549334842, 8115.188481151838, 5711.314642242957, 5918.17145599625, 5952.196453478725, 5970.194023806905, 5997.250343707036, 9867.16129129032, 10256.07695307426, 10259.281850270409, 10278.229132814919, 10350.275480716278, 10451.68644940653, 10584.047435730821, 10629.89370106289, 10679.839802402816, 10727.570897164025, 7948.244916732901, 7957.8408431832195, 8060.83878322442, 8128.512289262663, 8135.959320203361, 8540.615672294885, 8617.439866408664, 8662.263707584925, 8669.653213871374, 8690.695825646071, 7745.070591529053, 7853.72242049822, 7930.841383172419, 7930.9603451982375, 8058.758237252891, 7516.774496765106, 7520.811979700551, 7546.169921308761, 7682.654280557276, 7690.6539205737, 7030.964845175741, 7088.964555177191, 7100.928990710234, 7106.360427561544, 7111.751088711871, 4932.136876046606, 5076.898462030813, 5155.613329000415, 5212.713300768342, 5229.92155117666, 5089.898202035864, 5113.769880355468, 5179.689218646893, 5246.449122842199, 5248.291480650216], "value": 4624.97633023135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2434319455803, 304.04075142924074, 309.0604562131121, 312.91238453233103, 314.0, 5235.869103272411, 5251.159814429692, 5307.920381194285, 5308.150695888658, 5313.867153321169, 5201.90759940412, 5207.218917162428, 5214.426413094566, 5220.799216180271, 5243.9213411798755, 4106.240345536085, 4109.445224894645, 4116.382542618616, 4120.866761640543, 4130.987907962553, 4111.403846442264, 4116.773577453238, 4119.073208528072, 4124.484439445069, 4150.232207041707, 3994.560598334181, 4066.1054567994993, 4077.7349472284354, 4079.4084857695616, 4092.202020605983, 4028.5568587455355, 4033.3949907513816, 4039.8788036358956, 4057.5536690963972, 4081.6122468365456, 3596.4605309203566, 3600.71194304455, 3618.7285953553587, 3629.5825980012373, 3633.981830090859, 5043.84868453947, 5111.309973153614, 5132.692038477703, 5169.147090730025, 5194.532492075694, 4603.930941035887, 4619.422572178478, 4651.465081515636, 4656.953430465685, 4666.440027196758, 5457.945420545783, 5476.17857321405, 5481.808136715196, 5505.532029777473, 5507.118860982264, 3873.845046198149, 3920.137569734654, 3960.386140148282, 3977.76133431995, 3979.8408063677416, 5405.540529055035, 5548.972255138739, 5699.147776972501, 5703.914441283384, 5712.371639119735, 3886.7862267574988, 3891.610838916086, 3904.7852368119457, 3913.6086391361205, 4018.1160144768105, 4043.454133691973, 4058.6550143238155, 4066.2921572939435, 4066.7356621819486, 4068.3897415387337, 4380.496242932039, 4480.439945006874, 4599.793009314589, 4646.581807637329, 4649.5350464953235, 5452.664097296109, 5454.509094181542, 5460.590455715837, 5474.698891560923, 5478.780848766084, 1375.24361601119, 1383.5503461375092, 1391.193107997359, 1391.8538553451742, 1400.1529074909736, 857.3526987124806, 890.7817584691792, 893.489295080825, 905.9818803624022, 910.5811326789751, 4693.718376897397, 4697.271922851964, 4704.764761761967, 4707.411573553306, 4707.6233901287815, 4855.373449894254, 4934.753262336869, 4960.950390496121, 4968.801247950114, 5003.4746351633285, 4639.190715620911, 4660.464046634613, 4697.459792123881, 4705.341252224691, 4939.827106051271, 2957.0833041757123, 2981.4633365993895, 2997.250687328168, 3002.384511175204, 3012.5631783391723, 5734.942650573525, 5744.798932037359, 5745.6552606843725, 5769.365369809318, 5779.479846813723, 5501.449855014546, 5678.6371270895515, 5719.714014299351, 5725.85482903421, 5760.855978600484, 5725.456081672234, 5743.511801496919, 5792.594518383673, 5794.971025144931, 5797.8550536236935, 5502.669839809624, 5626.746796394254, 5668.801591944262, 5701.7149142541875, 5716.79991200306, 5330.360356757214, 5624.325080990144, 5628.718564071698, 5645.548356131581, 5645.604807663424, 5632.5212356950115, 5741.158126727297, 5765.365809760839, 5786.363500014911, 5789.507891829073, 3898.6491215790716, 3931.3906344516645, 3934.4098385241296, 3936.448897154458, 3960.821763020613, 5364.30264065669, 5567.635929197372, 5647.6329038614, 5648.943510564842, 5664.207011018543, 5471.6169868108855, 5517.944820551743, 5529.972350138223, 5537.667739935617, 5548.528375088163, 5515.676237703003, 5524.723763811713, 5525.502704756431, 5536.591582661556, 5538.307711536058, 5220.295260139985, 5456.890862182655, 5471.343438787212, 5479.287692599936, 5508.0, 5530.55755539564, 5549.112142057252, 5558.777648894161, 5561.304836895388, 5577.74900129487, 5166.922496162485, 5429.484199001088, 5435.728213589384, 5440.727963601883, 5479.123340265698], "value": 4128.88089866414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2008111158837, 750.5084169868735, 786.8504984053029, 795.1094773853285, 796.7689370082676, 14964.401423943043, 15753.684926301496, 15824.0, 15833.683326333467, 15866.286017129229, 14600.41598336068, 14737.631559211026, 14777.261136943163, 14779.704405911902, 14823.0, 650.801505540811, 781.9022622172229, 789.6525528767353, 805.6253841963486, 809.4738420026971, 798.0662624729052, 804.7344376355818, 806.7378102116807, 808.2483290539795, 808.8018435483315, 673.2930423055797, 838.5639467476939, 858.3905427146733, 859.6733241368303, 861.4745005546612, 608.9451949324559, 623.1307326279837, 624.3194917539903, 624.9625022498665, 626.1734510446213, 463.09927191612326, 463.4577544273208, 463.80520181523843, 464.64918986165566, 466.1725437348699, 13195.472181112744, 13370.0, 13382.531611393651, 13400.463981440731, 13474.326283685874, 13899.861001389958, 14275.143491390447, 14357.425702971868, 14452.421903123863, 14519.346629401596, 13206.339683015907, 13249.602511924657, 13409.128406653535, 13499.392527336293, 13536.120152190077, 4418.072204836956, 4462.933056004163, 4473.865784026484, 4520.751358675271, 4653.302004699289, 75328.62335688286, 76294.61852690701, 76529.0, 77418.61290693567, 81043.5947820263, 11488.0, 11670.416479176007, 11791.88208117925, 11870.94064529689, 11946.163768536293, 21569.460763481038, 21706.782932170478, 21756.673649895263, 21840.563188736138, 21856.89071554632, 8473.66105355779, 8473.83052338962, 8653.350998675125, 8671.089535598798, 8772.78068048291, 4564.543545645409, 4667.976660116746, 4720.268358404453, 4744.335792988915, 4884.120858245479, 3391.8982430527126, 3480.5301284326797, 3491.877784277538, 3495.702865256482, 3501.4222653262436, 593.9049752039653, 598.7395482964924, 605.3915814606293, 605.8909396308619, 618.7710547097603, 540.9404965453797, 593.9138824870456, 603.3693098092314, 674.9942585547597, 675.4393853101914, 9532.285078619132, 9592.232621390272, 9623.374480658735, 9693.273004524688, 10068.69793906184, 622.8038167977073, 632.3423639414957, 649.6199723162003, 663.3929954091952, 692.9376356127973, 4406.20688276107, 4464.821407143743, 4481.731096134177, 4610.216263235258, 4677.789499472532, 63944.0, 65238.0, 95052.0, 119826.40086799511, 123116.0, 100138.49930750299, 102948.0, 105311.0, 105653.47173264239, 107999.38000929993, 88899.0, 91071.0, 91151.54424227837, 92913.0708692918, 94095.52952235332, 8292.2951549119, 8444.863148555212, 8452.788680283042, 8482.533460659723, 8505.872411913702, 53415.73292133515, 53901.73049134886, 54277.0, 54741.178882316, 55745.721271393384, 67028.0, 76253.61873190598, 76455.61772191104, 76558.0, 77344.61327693326, 11420.988036200693, 11631.418429078343, 11689.0, 11770.588029419272, 12089.818652720392, 12535.185212961129, 12711.36443177819, 12998.480060797463, 13059.934700326437, 13364.732705345645, 12118.575849845212, 12235.69410764738, 12357.196782209128, 12458.813117803058, 12633.3683315832, 11692.532298707956, 12065.396730163633, 12229.816552751538, 12329.815052774395, 12752.553660621834, 11373.20387572895, 11859.288442693465, 11924.105692072955, 12065.758684826429, 12132.090093243218, 9404.623815047322, 9511.85745161892, 9629.0, 9649.228061755182, 9700.90299097, 9527.0, 9909.207263419054, 9917.851232231667, 10015.949920250352, 10027.899721002697], "value": 7194.761134151072, "unit": "score"}], "name": "dromaeo_css", "value": 7211.637119399688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 111.0, 110.0, 111.0, 110.0, 109.0, 111.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 119.0, 183.0, 124.0, 118.0, 141.0, 116.0, 145.0, 118.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 159.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 107.0, 76.0, 77.0, 77.0, 75.0, 111.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 114.0, 84.0, 85.0, 84.0, 122.0, 85.0, 86.0, 125.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 54.0, 66.0, 54.0, 53.0, 52.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 82.0, 77.0, 76.0, 76.0, 75.0, 75.0, 81.0, 80.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 117.0, 120.0, 122.0, 125.0, 119.0, 119.0, 163.0, 125.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 157.0, 156.0, 154.0, 159.0, 162.0, 157.0, 165.0, 159.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 63.0, 63.0, 63.0, 65.0, 64.0, 67.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1486.0000000000002, "alertThreshold": 2.0}]} 02:44:41 INFO - Return code: 0 02:44:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:44:41 INFO - # TBPL SUCCESS # 02:44:41 INFO - Running post-action listener: _resource_record_post_action 02:44:41 INFO - ##### 02:44:41 INFO - ##### Finished run-tests step (success) 02:44:41 INFO - ##### 02:44:41 INFO - Running post-run listener: _resource_record_post_run 02:44:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554524672; Read time: 12; Write time: 485260 02:44:41 INFO - TinderboxPrint: CPU usage
13.0% 02:44:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:44:41 INFO - TinderboxPrint: I/O write bytes / time
554,524,672 / 485,260 02:44:41 INFO - TinderboxPrint: CPU idle
8,266.0 (87.0%) 02:44:41 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 02:44:41 INFO - TinderboxPrint: Swap in / out
0 / 0 02:44:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256483328; Read time: 0; Write time: 257312 02:44:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297840640; Read time: 0; Write time: 227940 02:44:42 INFO - Running post-run listener: _upload_blobber_files 02:44:42 INFO - Blob upload gear active. 02:44:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:44:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:44:42 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'] 02:44:42 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 02:44:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:46 INFO - (blobuploader) - INFO - Done attempting. 02:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:44:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:47 INFO - (blobuploader) - INFO - Done attempting. 02:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:44:48 INFO - (blobuploader) - INFO - Done attempting. 02:44:48 INFO - (blobuploader) - INFO - Iteration through files over. 02:44:48 INFO - Return code: 0 02:44:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:44:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:44:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de88fd05563ff3c4f6f630edad043f7c8e196dce4022d11b32f5ce33671425e813bf1895878da285762561363944d72f17b28be237fd86d4d50e1d6743c09dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe81c07e4d90667fc32fca63d806f494ade6de8c26a8eb4192bc529a54ff7d4ebd712cbf4acfd29ef8a5ec0d256818696d9b72c9bc42ca086279785fcd38bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3283015e52794e0fa62d80acfd68bbacc5d61b45589fd828cf7e2feb085cd4ddbb194360cee8f59e3009506ae6608ed5a5e19372828c9d3ae45aa3f38d235e49"} 02:44:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:44:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:44:48 INFO - Contents: 02:44:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de88fd05563ff3c4f6f630edad043f7c8e196dce4022d11b32f5ce33671425e813bf1895878da285762561363944d72f17b28be237fd86d4d50e1d6743c09dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe81c07e4d90667fc32fca63d806f494ade6de8c26a8eb4192bc529a54ff7d4ebd712cbf4acfd29ef8a5ec0d256818696d9b72c9bc42ca086279785fcd38bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3283015e52794e0fa62d80acfd68bbacc5d61b45589fd828cf7e2feb085cd4ddbb194360cee8f59e3009506ae6608ed5a5e19372828c9d3ae45aa3f38d235e49"} 02:44:48 INFO - Running post-run listener: copy_logs_to_upload_dir 02:44:48 INFO - Copying logs to upload dir... 02:44:48 INFO - mkdir: /builds/slave/test/build/upload/logs 02:44:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.786658 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-07 02:44:48.257100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:44:48.260455) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 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/de88fd05563ff3c4f6f630edad043f7c8e196dce4022d11b32f5ce33671425e813bf1895878da285762561363944d72f17b28be237fd86d4d50e1d6743c09dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe81c07e4d90667fc32fca63d806f494ade6de8c26a8eb4192bc529a54ff7d4ebd712cbf4acfd29ef8a5ec0d256818696d9b72c9bc42ca086279785fcd38bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3283015e52794e0fa62d80acfd68bbacc5d61b45589fd828cf7e2feb085cd4ddbb194360cee8f59e3009506ae6608ed5a5e19372828c9d3ae45aa3f38d235e49"} build_url:https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/GG5EHpnQRhGKnWp09SbK5g/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/de88fd05563ff3c4f6f630edad043f7c8e196dce4022d11b32f5ce33671425e813bf1895878da285762561363944d72f17b28be237fd86d4d50e1d6743c09dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe81c07e4d90667fc32fca63d806f494ade6de8c26a8eb4192bc529a54ff7d4ebd712cbf4acfd29ef8a5ec0d256818696d9b72c9bc42ca086279785fcd38bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3283015e52794e0fa62d80acfd68bbacc5d61b45589fd828cf7e2feb085cd4ddbb194360cee8f59e3009506ae6608ed5a5e19372828c9d3ae45aa3f38d235e49"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:44:48.285958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:44:48.286279) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467883326.978610-1031127619 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:44:48.335852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:44:48.336169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:44:48.336457) ========= ========= Total master_lag: 0.13 =========